builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-057 starttime: 1465416974.34 results: success (0) buildid: 20160608125329 builduid: 6be25b12d1b043728d7a77a118c51feb revision: ded915ec401f6690c95486a68ac2546806aa3227 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-08 13:16:14.338098) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-08 13:16:14.339067) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-08 13:16:14.339796) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-08 13:16:14.357223) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 13:16:14.357922) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1465416973.972780-1410721315 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-08 13:16:14-- 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% 214M=0s 2016-06-08 13:16:14 (214 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.086593 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 13:16:14.460872) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 13:16:14.461421) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1465416973.972780-1410721315 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016083 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 13:16:14.513591) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-08 13:16:14.514352) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev ded915ec401f6690c95486a68ac2546806aa3227 --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 ded915ec401f6690c95486a68ac2546806aa3227 --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=934fc3100db09dcb9af4d4b6000001ab-1465416973.972780-1410721315 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-08 13:16:14,908 truncating revision to first 12 chars 2016-06-08 13:16:14,908 Setting DEBUG logging. 2016-06-08 13:16:14,908 attempt 1/10 2016-06-08 13:16:14,908 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/ded915ec401f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-08 13:16:16,066 unpacking tar archive at: fx-team-ded915ec401f/testing/mozharness/ program finished with exit code 0 elapsedTime=1.499513 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-08 13:16:16.032797) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-08 13:16:16.033627) ========= script_repo_revision: ded915ec401f6690c95486a68ac2546806aa3227 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-08 13:16:16.034600) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-08 13:16:16.035306) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-08 13:16:16.046827) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-06-08 13:16:16.047183) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 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-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] 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=934fc3100db09dcb9af4d4b6000001ab-1465416973.972780-1410721315 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:16:16 INFO - MultiFileLogger online at 20160608 13:16:16 in /builds/slave/test 13:16:16 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 13:16:16 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:16:16 INFO - {'append_to_log': False, 13:16:16 INFO - 'base_work_dir': '/builds/slave/test', 13:16:16 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 13:16:16 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:16:16 INFO - 'branch': 'Fx-Team-Non-PGO', 13:16:16 INFO - 'buildbot_json_path': 'buildprops.json', 13:16:16 INFO - 'config_files': ('talos/linux_config.py',), 13:16:16 INFO - 'default_actions': ('clobber', 13:16:16 INFO - 'read-buildbot-config', 13:16:16 INFO - 'download-and-extract', 13:16:16 INFO - 'populate-webroot', 13:16:16 INFO - 'create-virtualenv', 13:16:16 INFO - 'install', 13:16:16 INFO - 'run-tests'), 13:16:16 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:16:16 INFO - 'download_minidump_stackwalk': True, 13:16:16 INFO - 'download_symbols': 'ondemand', 13:16:16 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:16:16 INFO - 'tooltool.py': '/tools/tooltool.py', 13:16:16 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:16:16 INFO - '/tools/misc-python/virtualenv.py')}, 13:16:16 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:16:16 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:16:16 INFO - 'installer_path': 'installer.exe', 13:16:16 INFO - 'log_level': 'info', 13:16:16 INFO - 'log_name': 'talos', 13:16:16 INFO - 'log_to_console': True, 13:16:16 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:16:16 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:16:16 INFO - 'opt_config_files': (), 13:16:16 INFO - 'pip_index': False, 13:16:16 INFO - 'sps_profile': False, 13:16:16 INFO - 'sps_profile_interval': 0, 13:16:16 INFO - 'suite': 'dromaeojs-e10s', 13:16:16 INFO - 'system_bits': '32', 13:16:16 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:16:16 INFO - 'title': 'talos-linux64-ix-057', 13:16:16 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:16:16 INFO - 'use_talos_json': True, 13:16:16 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:16:16 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:16:16 INFO - 'work_dir': 'build'} 13:16:16 INFO - ##### 13:16:16 INFO - ##### Running clobber step. 13:16:16 INFO - ##### 13:16:16 INFO - Running pre-action listener: _resource_record_pre_action 13:16:16 INFO - Running main action method: clobber 13:16:16 INFO - rmtree: /builds/slave/test/build 13:16:16 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:16:17 INFO - Running post-action listener: _resource_record_post_action 13:16:17 INFO - ##### 13:16:17 INFO - ##### Finished clobber step (success) 13:16:17 INFO - ##### 13:16:17 INFO - ##### 13:16:17 INFO - ##### Running read-buildbot-config step. 13:16:17 INFO - ##### 13:16:17 INFO - Running pre-action listener: _resource_record_pre_action 13:16:17 INFO - Running main action method: read_buildbot_config 13:16:17 INFO - Using buildbot properties: 13:16:17 INFO - { 13:16:17 INFO - "project": "", 13:16:17 INFO - "product": "firefox", 13:16:17 INFO - "script_repo_revision": "production", 13:16:17 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 13:16:17 INFO - "repository": "", 13:16:17 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 13:16:17 INFO - "buildid": "20160608125329", 13:16:17 INFO - "pgo_build": "False", 13:16:17 INFO - "basedir": "/builds/slave/test", 13:16:17 INFO - "buildnumber": 1384, 13:16:17 INFO - "slavename": "talos-linux64-ix-057", 13:16:17 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 13:16:17 INFO - "platform": "ubuntu64_hw", 13:16:17 INFO - "scheduler": "tests-fx-team-linux64-talos", 13:16:17 INFO - "branch": "fx-team", 13:16:17 INFO - "repo_path": "integration/fx-team", 13:16:17 INFO - "revision": "ded915ec401f6690c95486a68ac2546806aa3227", 13:16:17 INFO - "stage_platform": "linux64", 13:16:17 INFO - "builduid": "6be25b12d1b043728d7a77a118c51feb", 13:16:17 INFO - "slavebuilddir": "test" 13:16:17 INFO - } 13:16:17 INFO - Found installer url https://queue.taskcluster.net/v1/task/HquYGC6qQ4KjeSKvfyHVWA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 13:16:17 INFO - Running post-action listener: _resource_record_post_action 13:16:17 INFO - ##### 13:16:17 INFO - ##### Finished read-buildbot-config step (success) 13:16:17 INFO - ##### 13:16:17 INFO - ##### 13:16:17 INFO - ##### Running download-and-extract step. 13:16:17 INFO - ##### 13:16:17 INFO - Running pre-action listener: _resource_record_pre_action 13:16:17 INFO - Running main action method: download_and_extract 13:16:17 INFO - mkdir: /builds/slave/test/build/tests 13:16:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:16:17 INFO - https://queue.taskcluster.net/v1/task/HquYGC6qQ4KjeSKvfyHVWA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 13:16:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HquYGC6qQ4KjeSKvfyHVWA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 13:16:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HquYGC6qQ4KjeSKvfyHVWA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 13:16:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HquYGC6qQ4KjeSKvfyHVWA/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 13:16:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HquYGC6qQ4KjeSKvfyHVWA/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 13:16:17 INFO - Downloaded 1361 bytes. 13:16:17 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 13:16:17 INFO - Using the following test package requirements: 13:16:17 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 13:16:17 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:16:17 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 13:16:17 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:16:17 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 13:16:17 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:16:17 INFO - u'jsshell-linux-x86_64.zip'], 13:16:17 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:16:17 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 13:16:17 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 13:16:17 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:16:17 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 13:16:17 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:16:17 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 13:16:17 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:16:17 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 13:16:17 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:16:17 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 13:16:17 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 13:16:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:16:17 INFO - https://queue.taskcluster.net/v1/task/HquYGC6qQ4KjeSKvfyHVWA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:16:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HquYGC6qQ4KjeSKvfyHVWA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 13:16:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HquYGC6qQ4KjeSKvfyHVWA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 13:16:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HquYGC6qQ4KjeSKvfyHVWA/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 13:16:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HquYGC6qQ4KjeSKvfyHVWA/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 13:16:19 INFO - Downloaded 22878699 bytes. 13:16:19 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'] 13:16:19 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 13:16:20 INFO - Return code: 0 13:16:20 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 13:16:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:16:20 INFO - https://queue.taskcluster.net/v1/task/HquYGC6qQ4KjeSKvfyHVWA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:16:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HquYGC6qQ4KjeSKvfyHVWA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 13:16:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HquYGC6qQ4KjeSKvfyHVWA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 13:16:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HquYGC6qQ4KjeSKvfyHVWA/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 13:16:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HquYGC6qQ4KjeSKvfyHVWA/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 13:16:22 INFO - Downloaded 22878699 bytes. 13:16:22 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'] 13:16:22 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 13:16:23 INFO - Return code: 0 13:16:23 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')]} 13:16:23 INFO - https://queue.taskcluster.net/v1/task/HquYGC6qQ4KjeSKvfyHVWA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 13:16:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HquYGC6qQ4KjeSKvfyHVWA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 13:16:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HquYGC6qQ4KjeSKvfyHVWA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 13:16:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HquYGC6qQ4KjeSKvfyHVWA/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 13:16:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HquYGC6qQ4KjeSKvfyHVWA/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 13:16:24 INFO - Downloaded 10833369 bytes. 13:16:24 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'] 13:16:24 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 13:16:24 INFO - Return code: 0 13:16:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:16:24 INFO - https://queue.taskcluster.net/v1/task/HquYGC6qQ4KjeSKvfyHVWA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 13:16:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HquYGC6qQ4KjeSKvfyHVWA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 13:16:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HquYGC6qQ4KjeSKvfyHVWA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 13:16:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HquYGC6qQ4KjeSKvfyHVWA/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 13:16:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HquYGC6qQ4KjeSKvfyHVWA/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 13:16:26 INFO - Downloaded 55369135 bytes. 13:16:26 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/HquYGC6qQ4KjeSKvfyHVWA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 13:16:26 INFO - mkdir: /builds/slave/test/properties 13:16:26 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:16:26 INFO - Writing to file /builds/slave/test/properties/build_url 13:16:26 INFO - Contents: 13:16:26 INFO - build_url:https://queue.taskcluster.net/v1/task/HquYGC6qQ4KjeSKvfyHVWA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 13:16:27 INFO - Running post-action listener: _resource_record_post_action 13:16:27 INFO - Running post-action listener: set_extra_try_arguments 13:16:27 INFO - ##### 13:16:27 INFO - ##### Finished download-and-extract step (success) 13:16:27 INFO - ##### 13:16:27 INFO - ##### 13:16:27 INFO - ##### Running populate-webroot step. 13:16:27 INFO - ##### 13:16:27 INFO - Running pre-action listener: _resource_record_pre_action 13:16:27 INFO - Running main action method: populate_webroot 13:16:27 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:16:27 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:16:27 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:16:27 INFO - '--tppagecycles', 13:16:27 INFO - '7'], 13:16:27 INFO - 'tests': ['tsvgm']}}, 13:16:27 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:16:27 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:16:27 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:16:27 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:16:27 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:16:27 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:16:27 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:16:27 INFO - 'talos_options': ['--disable-e10s'], 13:16:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:16:27 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:16:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:16:27 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:16:27 INFO - 'talos_options': ['--disable-e10s'], 13:16:27 INFO - 'tests': ['damp', 'tps']}, 13:16:27 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:16:27 INFO - 'tests': ['damp', 'tps']}, 13:16:27 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:16:27 INFO - 'tests': ['dromaeo_dom']}, 13:16:27 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:16:27 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:16:27 INFO - 'tests': ['a11yr', 13:16:27 INFO - 'ts_paint', 13:16:27 INFO - 'tpaint', 13:16:27 INFO - 'sessionrestore', 13:16:27 INFO - 'sessionrestore_no_auto_restore', 13:16:27 INFO - 'tabpaint']}, 13:16:27 INFO - 'other-e10s': {'tests': ['a11yr', 13:16:27 INFO - 'ts_paint', 13:16:27 INFO - 'tpaint', 13:16:27 INFO - 'sessionrestore', 13:16:27 INFO - 'sessionrestore_no_auto_restore', 13:16:27 INFO - 'tabpaint']}, 13:16:27 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:16:27 INFO - 'ts_paint', 13:16:27 INFO - 'tpaint', 13:16:27 INFO - 'sessionrestore', 13:16:27 INFO - 'sessionrestore_no_auto_restore', 13:16:27 INFO - 'tabpaint']}, 13:16:27 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:16:27 INFO - 'ts_paint', 13:16:27 INFO - 'tpaint', 13:16:27 INFO - 'sessionrestore', 13:16:27 INFO - 'sessionrestore_no_auto_restore', 13:16:27 INFO - 'tabpaint']}, 13:16:27 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:16:27 INFO - 'tests': ['a11yr', 13:16:27 INFO - 'ts_paint', 13:16:27 INFO - 'tpaint', 13:16:27 INFO - 'sessionrestore', 13:16:27 INFO - 'sessionrestore_no_auto_restore', 13:16:27 INFO - 'tabpaint']}, 13:16:27 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:16:27 INFO - 'tests': ['a11yr', 13:16:27 INFO - 'ts_paint', 13:16:27 INFO - 'tpaint', 13:16:27 INFO - 'sessionrestore', 13:16:27 INFO - 'sessionrestore_no_auto_restore', 13:16:27 INFO - 'tabpaint']}, 13:16:27 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:16:27 INFO - 'tests': ['tsvgx', 13:16:27 INFO - 'tsvgr_opacity', 13:16:27 INFO - 'tart', 13:16:27 INFO - 'tscrollx', 13:16:27 INFO - 'cart']}, 13:16:27 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:16:27 INFO - 'tsvgr_opacity', 13:16:27 INFO - 'tart', 13:16:27 INFO - 'tscrollx', 13:16:27 INFO - 'cart']}, 13:16:27 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:16:27 INFO - 'talos_options': ['--disable-e10s'], 13:16:27 INFO - 'tests': ['tp5o']}, 13:16:27 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:16:27 INFO - 'tests': ['tp5o']}, 13:16:27 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:16:27 INFO - 'talos_options': ['--disable-e10s', 13:16:27 INFO - '--xperf_path', 13:16:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:16:27 INFO - 'tests': ['tp5n']}, 13:16:27 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:16:27 INFO - 'talos_options': ['--xperf_path', 13:16:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:16:27 INFO - 'tests': ['tp5n']}}, 13:16:27 INFO - 'talos.zip': {'path': '', 13:16:27 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:16:27 INFO - Running post-action listener: _resource_record_post_action 13:16:27 INFO - ##### 13:16:27 INFO - ##### Finished populate-webroot step (success) 13:16:27 INFO - ##### 13:16:27 INFO - ##### 13:16:27 INFO - ##### Running create-virtualenv step. 13:16:27 INFO - ##### 13:16:27 INFO - Running pre-action listener: _resource_record_pre_action 13:16:27 INFO - Running main action method: create_virtualenv 13:16:27 INFO - Creating virtualenv /builds/slave/test/build/venv 13:16:27 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 13:16:27 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:16:27 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:16:27 INFO - Using real prefix '/usr' 13:16:27 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:16:28 INFO - Installing distribute.............................................................................................................................................................................................done. 13:16:30 INFO - Installing pip.................done. 13:16:30 INFO - Return code: 0 13:16:30 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:16:30 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')]} 13:16:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:16:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:16:30 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')]} 13:16:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:16:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:16:30 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 0x7fbd930b2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19c18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a8e020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b202e0>, '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 0x1a8c140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a8c5d0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1465416973.972780-1410721315', '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 13:16:30 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 13:16:30 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 13:16:30 INFO - Using env: {'DISPLAY': ':0', 13:16:30 INFO - 'HOME': '/home/cltbld', 13:16:30 INFO - 'LANG': 'en_US.UTF-8', 13:16:30 INFO - 'LANGUAGE': 'en_US:en', 13:16:30 INFO - 'LOGNAME': 'cltbld', 13:16:30 INFO - 'MAIL': '/var/mail/cltbld', 13:16:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:16:30 INFO - 'MOZ_NO_REMOTE': '1', 13:16:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:16:30 INFO - 'NO_EM_RESTART': '1', 13:16:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:16:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:16:30 INFO - 'PWD': '/builds/slave/test', 13:16:30 INFO - 'SHELL': '/bin/bash', 13:16:30 INFO - 'SHLVL': '1', 13:16:30 INFO - 'TERM': 'linux', 13:16:30 INFO - 'TMOUT': '86400', 13:16:30 INFO - 'USER': 'cltbld', 13:16:30 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1465416973.972780-1410721315', 13:16:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:16:30 INFO - '_': '/tools/buildbot/bin/python'} 13:16:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:16:30 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 13:16:30 INFO - Cleaning up... 13:16:30 INFO - Return code: 0 13:16:30 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:16:30 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')]} 13:16:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:16:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:16:30 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')]} 13:16:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:16:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:16:30 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 0x7fbd930b2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19c18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a8e020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b202e0>, '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 0x1a8c140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a8c5d0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1465416973.972780-1410721315', '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 13:16:30 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 13:16:30 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 13:16:30 INFO - Using env: {'DISPLAY': ':0', 13:16:30 INFO - 'HOME': '/home/cltbld', 13:16:30 INFO - 'LANG': 'en_US.UTF-8', 13:16:30 INFO - 'LANGUAGE': 'en_US:en', 13:16:30 INFO - 'LOGNAME': 'cltbld', 13:16:30 INFO - 'MAIL': '/var/mail/cltbld', 13:16:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:16:30 INFO - 'MOZ_NO_REMOTE': '1', 13:16:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:16:30 INFO - 'NO_EM_RESTART': '1', 13:16:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:16:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:16:30 INFO - 'PWD': '/builds/slave/test', 13:16:30 INFO - 'SHELL': '/bin/bash', 13:16:30 INFO - 'SHLVL': '1', 13:16:30 INFO - 'TERM': 'linux', 13:16:30 INFO - 'TMOUT': '86400', 13:16:30 INFO - 'USER': 'cltbld', 13:16:30 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1465416973.972780-1410721315', 13:16:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:16:30 INFO - '_': '/tools/buildbot/bin/python'} 13:16:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:16:30 INFO - Downloading/unpacking psutil>=3.1.1 13:16:30 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 13:16:30 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 13:16:30 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 13:16:30 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 13:16:30 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 13:16:30 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 13:16:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:16:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:16:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:16:32 INFO - Installing collected packages: psutil 13:16:32 INFO - Running setup.py install for psutil 13:16:32 INFO - building 'psutil._psutil_linux' extension 13:16:32 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 13:16:32 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 13:16:32 INFO - building 'psutil._psutil_posix' extension 13:16:32 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 13:16:32 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 13:16:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:16:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:16:33 INFO - Successfully installed psutil 13:16:33 INFO - Cleaning up... 13:16:33 INFO - Return code: 0 13:16:33 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 13:16:33 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')]} 13:16:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:16:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:16:33 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')]} 13:16:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:16:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:16:33 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 0x7fbd930b2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19c18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a8e020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b202e0>, '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 0x1a8c140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a8c5d0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1465416973.972780-1410721315', '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 13:16:33 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 13:16:33 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 13:16:33 INFO - Using env: {'DISPLAY': ':0', 13:16:33 INFO - 'HOME': '/home/cltbld', 13:16:33 INFO - 'LANG': 'en_US.UTF-8', 13:16:33 INFO - 'LANGUAGE': 'en_US:en', 13:16:33 INFO - 'LOGNAME': 'cltbld', 13:16:33 INFO - 'MAIL': '/var/mail/cltbld', 13:16:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:16:33 INFO - 'MOZ_NO_REMOTE': '1', 13:16:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:16:33 INFO - 'NO_EM_RESTART': '1', 13:16:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:16:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:16:33 INFO - 'PWD': '/builds/slave/test', 13:16:33 INFO - 'SHELL': '/bin/bash', 13:16:33 INFO - 'SHLVL': '1', 13:16:33 INFO - 'TERM': 'linux', 13:16:33 INFO - 'TMOUT': '86400', 13:16:33 INFO - 'USER': 'cltbld', 13:16:33 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1465416973.972780-1410721315', 13:16:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:16:33 INFO - '_': '/tools/buildbot/bin/python'} 13:16:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:16:33 INFO - Downloading/unpacking mozsystemmonitor==0.3 13:16:33 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 13:16:33 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 13:16:33 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 13:16:33 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 13:16:33 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 13:16:33 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 13:16:35 INFO - Downloading mozsystemmonitor-0.3.tar.gz 13:16:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:16:35 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 13:16:35 INFO - Installing collected packages: mozsystemmonitor 13:16:35 INFO - Running setup.py install for mozsystemmonitor 13:16:35 INFO - Successfully installed mozsystemmonitor 13:16:35 INFO - Cleaning up... 13:16:35 INFO - Return code: 0 13:16:35 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 13:16:35 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')]} 13:16:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:16:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:16:35 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')]} 13:16:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:16:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:16:35 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 0x7fbd930b2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19c18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a8e020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b202e0>, '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 0x1a8c140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a8c5d0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1465416973.972780-1410721315', '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 13:16:35 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 13:16:35 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 13:16:35 INFO - Using env: {'DISPLAY': ':0', 13:16:35 INFO - 'HOME': '/home/cltbld', 13:16:35 INFO - 'LANG': 'en_US.UTF-8', 13:16:35 INFO - 'LANGUAGE': 'en_US:en', 13:16:35 INFO - 'LOGNAME': 'cltbld', 13:16:35 INFO - 'MAIL': '/var/mail/cltbld', 13:16:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:16:35 INFO - 'MOZ_NO_REMOTE': '1', 13:16:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:16:35 INFO - 'NO_EM_RESTART': '1', 13:16:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:16:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:16:35 INFO - 'PWD': '/builds/slave/test', 13:16:35 INFO - 'SHELL': '/bin/bash', 13:16:35 INFO - 'SHLVL': '1', 13:16:35 INFO - 'TERM': 'linux', 13:16:35 INFO - 'TMOUT': '86400', 13:16:35 INFO - 'USER': 'cltbld', 13:16:35 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1465416973.972780-1410721315', 13:16:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:16:35 INFO - '_': '/tools/buildbot/bin/python'} 13:16:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:16:35 INFO - Downloading/unpacking jsonschema==2.5.1 13:16:35 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 13:16:35 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 13:16:35 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 13:16:35 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 13:16:35 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 13:16:35 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 13:16:37 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:16:37 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 13:16:37 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 13:16:37 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 13:16:37 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 13:16:37 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 13:16:37 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 13:16:37 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 13:16:37 INFO - Downloading functools32-3.2.3-2.tar.gz 13:16:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:16:37 INFO - warning: no files found matching '*.txt' 13:16:37 INFO - no previously-included directories found matching 'build' 13:16:37 INFO - no previously-included directories found matching 'dist' 13:16:37 INFO - no previously-included directories found matching '.git*' 13:16:37 INFO - Installing collected packages: jsonschema, functools32 13:16:37 INFO - Running setup.py install for functools32 13:16:37 INFO - warning: no files found matching '*.txt' 13:16:37 INFO - no previously-included directories found matching 'build' 13:16:37 INFO - no previously-included directories found matching 'dist' 13:16:37 INFO - no previously-included directories found matching '.git*' 13:16:37 INFO - Successfully installed jsonschema functools32 13:16:37 INFO - Cleaning up... 13:16:38 INFO - Return code: 0 13:16:38 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:16:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:16:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:16:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:16:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:16:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:16:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:16:38 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 0x7fbd930b2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19c18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a8e020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b202e0>, '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 0x1a8c140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a8c5d0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1465416973.972780-1410721315', '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 13:16:38 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 13:16:38 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 13:16:38 INFO - Using env: {'DISPLAY': ':0', 13:16:38 INFO - 'HOME': '/home/cltbld', 13:16:38 INFO - 'LANG': 'en_US.UTF-8', 13:16:38 INFO - 'LANGUAGE': 'en_US:en', 13:16:38 INFO - 'LOGNAME': 'cltbld', 13:16:38 INFO - 'MAIL': '/var/mail/cltbld', 13:16:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:16:38 INFO - 'MOZ_NO_REMOTE': '1', 13:16:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:16:38 INFO - 'NO_EM_RESTART': '1', 13:16:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:16:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:16:38 INFO - 'PWD': '/builds/slave/test', 13:16:38 INFO - 'SHELL': '/bin/bash', 13:16:38 INFO - 'SHLVL': '1', 13:16:38 INFO - 'TERM': 'linux', 13:16:38 INFO - 'TMOUT': '86400', 13:16:38 INFO - 'USER': 'cltbld', 13:16:38 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1465416973.972780-1410721315', 13:16:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:16:38 INFO - '_': '/tools/buildbot/bin/python'} 13:16:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:16:38 INFO - Downloading/unpacking blobuploader==1.2.4 13:16:38 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 13:16:38 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 13:16:38 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 13:16:38 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 13:16:38 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 13:16:38 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 13:16:40 INFO - Downloading blobuploader-1.2.4.tar.gz 13:16:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:16:40 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:16:40 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 13:16:40 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 13:16:40 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 13:16:40 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 13:16:40 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 13:16:40 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 13:16:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:16:40 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:16:40 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 13:16:40 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 13:16:40 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 13:16:40 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 13:16:40 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 13:16:40 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 13:16:40 INFO - Downloading docopt-0.6.1.tar.gz 13:16:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:16:40 INFO - Installing collected packages: blobuploader, requests, docopt 13:16:40 INFO - Running setup.py install for blobuploader 13:16:40 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:16:40 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:16:40 INFO - Running setup.py install for requests 13:16:41 INFO - Running setup.py install for docopt 13:16:41 INFO - Successfully installed blobuploader requests docopt 13:16:41 INFO - Cleaning up... 13:16:41 INFO - Return code: 0 13:16:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:16:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:16:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:16:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:16:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:16:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:16:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:16:41 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 0x7fbd930b2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19c18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a8e020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b202e0>, '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 0x1a8c140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a8c5d0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1465416973.972780-1410721315', '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 13:16:41 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 13:16:41 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 13:16:41 INFO - Using env: {'DISPLAY': ':0', 13:16:41 INFO - 'HOME': '/home/cltbld', 13:16:41 INFO - 'LANG': 'en_US.UTF-8', 13:16:41 INFO - 'LANGUAGE': 'en_US:en', 13:16:41 INFO - 'LOGNAME': 'cltbld', 13:16:41 INFO - 'MAIL': '/var/mail/cltbld', 13:16:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:16:41 INFO - 'MOZ_NO_REMOTE': '1', 13:16:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:16:41 INFO - 'NO_EM_RESTART': '1', 13:16:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:16:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:16:41 INFO - 'PWD': '/builds/slave/test', 13:16:41 INFO - 'SHELL': '/bin/bash', 13:16:41 INFO - 'SHLVL': '1', 13:16:41 INFO - 'TERM': 'linux', 13:16:41 INFO - 'TMOUT': '86400', 13:16:41 INFO - 'USER': 'cltbld', 13:16:41 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1465416973.972780-1410721315', 13:16:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:16:41 INFO - '_': '/tools/buildbot/bin/python'} 13:16:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:16:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:16:41 INFO - Running setup.py (path:/tmp/pip-T1yXHR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:16:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:16:41 INFO - Running setup.py (path:/tmp/pip-gytxYx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:16:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:16:41 INFO - Running setup.py (path:/tmp/pip-7TtvnA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:16:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:16:41 INFO - Running setup.py (path:/tmp/pip-TCLnDi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:16:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:16:41 INFO - Running setup.py (path:/tmp/pip-p3WJ1a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:16:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:16:42 INFO - Running setup.py (path:/tmp/pip-20hhF1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:16:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:16:42 INFO - Running setup.py (path:/tmp/pip-KJDPpp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:16:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:16:42 INFO - Running setup.py (path:/tmp/pip-uH1la2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:16:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:16:42 INFO - Running setup.py (path:/tmp/pip-socCTb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:16:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:16:42 INFO - Running setup.py (path:/tmp/pip-X046gP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:16:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:16:42 INFO - Running setup.py (path:/tmp/pip-TslW9H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:16:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:16:42 INFO - Running setup.py (path:/tmp/pip-Jvz8YW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:16:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:16:42 INFO - Running setup.py (path:/tmp/pip-a6CFUT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:16:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:16:42 INFO - Running setup.py (path:/tmp/pip-eAVxvV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:16:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:16:42 INFO - Running setup.py (path:/tmp/pip-prHXCu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:16:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:16:42 INFO - Running setup.py (path:/tmp/pip-rBUoTf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:16:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:16:42 INFO - Running setup.py (path:/tmp/pip-ZNcEjY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:16:42 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:16:42 INFO - Running setup.py install for manifestparser 13:16:43 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:16:43 INFO - Running setup.py install for mozcrash 13:16:43 INFO - Running setup.py install for mozdebug 13:16:43 INFO - Running setup.py install for mozdevice 13:16:43 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:16:43 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:16:43 INFO - Running setup.py install for mozfile 13:16:43 INFO - Running setup.py install for mozhttpd 13:16:43 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:16:43 INFO - Running setup.py install for mozinfo 13:16:43 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:16:43 INFO - Running setup.py install for mozInstall 13:16:43 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:16:43 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:16:43 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:16:43 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:16:43 INFO - Running setup.py install for mozleak 13:16:43 INFO - Running setup.py install for mozlog 13:16:43 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:16:43 INFO - Running setup.py install for moznetwork 13:16:44 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:16:44 INFO - Running setup.py install for mozprocess 13:16:44 INFO - Running setup.py install for mozprofile 13:16:44 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:16:44 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:16:44 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:16:44 INFO - Running setup.py install for mozrunner 13:16:44 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:16:44 INFO - Running setup.py install for mozscreenshot 13:16:44 INFO - Running setup.py install for moztest 13:16:44 INFO - Running setup.py install for mozversion 13:16:44 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:16:44 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:16:44 INFO - Cleaning up... 13:16:44 INFO - Return code: 0 13:16:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:16:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:16:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:16:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:16:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:16:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:16:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:16:44 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 0x7fbd930b2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19c18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a8e020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b202e0>, '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 0x1a8c140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a8c5d0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1465416973.972780-1410721315', '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 13:16:44 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 13:16:44 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 13:16:44 INFO - Using env: {'DISPLAY': ':0', 13:16:44 INFO - 'HOME': '/home/cltbld', 13:16:44 INFO - 'LANG': 'en_US.UTF-8', 13:16:44 INFO - 'LANGUAGE': 'en_US:en', 13:16:44 INFO - 'LOGNAME': 'cltbld', 13:16:44 INFO - 'MAIL': '/var/mail/cltbld', 13:16:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:16:44 INFO - 'MOZ_NO_REMOTE': '1', 13:16:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:16:44 INFO - 'NO_EM_RESTART': '1', 13:16:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:16:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:16:44 INFO - 'PWD': '/builds/slave/test', 13:16:44 INFO - 'SHELL': '/bin/bash', 13:16:44 INFO - 'SHLVL': '1', 13:16:44 INFO - 'TERM': 'linux', 13:16:44 INFO - 'TMOUT': '86400', 13:16:44 INFO - 'USER': 'cltbld', 13:16:44 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1465416973.972780-1410721315', 13:16:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:16:44 INFO - '_': '/tools/buildbot/bin/python'} 13:16:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:16:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:16:44 INFO - Running setup.py (path:/tmp/pip-LBX1UG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:16:45 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)) 13:16:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:16:45 INFO - Running setup.py (path:/tmp/pip-v_TvR0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:16:45 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)) 13:16:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:16:45 INFO - Running setup.py (path:/tmp/pip-mjGj9o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:16:45 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)) 13:16:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:16:45 INFO - Running setup.py (path:/tmp/pip-fAK9tO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:16:45 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)) 13:16:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:16:45 INFO - Running setup.py (path:/tmp/pip-bKajWt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:16:45 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)) 13:16:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:16:45 INFO - Running setup.py (path:/tmp/pip-FK6ae8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:16:45 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)) 13:16:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:16:45 INFO - Running setup.py (path:/tmp/pip-n_VZ2D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:16:45 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)) 13:16:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:16:45 INFO - Running setup.py (path:/tmp/pip-6GE9fG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:16:45 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)) 13:16:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:16:45 INFO - Running setup.py (path:/tmp/pip-BOkdzd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:16:45 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)) 13:16:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:16:45 INFO - Running setup.py (path:/tmp/pip-FqoLwW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:16:45 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)) 13:16:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:16:45 INFO - Running setup.py (path:/tmp/pip-Ql2Epn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:16:45 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)) 13:16:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:16:45 INFO - Running setup.py (path:/tmp/pip-AOefv5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:16:45 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)) 13:16:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:16:45 INFO - Running setup.py (path:/tmp/pip-Xva127-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:16:45 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)) 13:16:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:16:45 INFO - Running setup.py (path:/tmp/pip-9eFlzQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:16:45 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)) 13:16:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:16:45 INFO - Running setup.py (path:/tmp/pip-JBggfJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:16:46 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)) 13:16:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:16:46 INFO - Running setup.py (path:/tmp/pip-1v9P_r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:16:46 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)) 13:16:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:16:46 INFO - Running setup.py (path:/tmp/pip-lC_u4d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:16:46 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)) 13:16:46 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)) 13:16:46 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)) 13:16:46 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)) 13:16:46 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)) 13:16:46 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)) 13:16:46 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:16:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:16:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:16:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:16:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:16:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:16:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:16:48 INFO - Downloading blessings-1.6.tar.gz 13:16:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:16:48 INFO - Installing collected packages: blessings 13:16:48 INFO - Running setup.py install for blessings 13:16:48 INFO - Successfully installed blessings 13:16:48 INFO - Cleaning up... 13:16:48 INFO - Return code: 0 13:16:48 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:16:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:16:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:16:48 INFO - Reading from file tmpfile_stdout 13:16:48 INFO - Current package versions: 13:16:48 INFO - argparse == 1.2.1 13:16:48 INFO - blessings == 1.6 13:16:48 INFO - blobuploader == 1.2.4 13:16:48 INFO - docopt == 0.6.1 13:16:48 INFO - functools32 == 3.2.3-2 13:16:48 INFO - jsonschema == 2.5.1 13:16:48 INFO - manifestparser == 1.1 13:16:48 INFO - mozInstall == 1.12 13:16:48 INFO - mozcrash == 0.17 13:16:48 INFO - mozdebug == 0.1 13:16:48 INFO - mozdevice == 0.48 13:16:48 INFO - mozfile == 1.2 13:16:48 INFO - mozhttpd == 0.7 13:16:48 INFO - mozinfo == 0.9 13:16:48 INFO - mozleak == 0.1 13:16:48 INFO - mozlog == 3.2 13:16:48 INFO - moznetwork == 0.27 13:16:48 INFO - mozprocess == 0.22 13:16:48 INFO - mozprofile == 0.28 13:16:48 INFO - mozrunner == 6.11 13:16:48 INFO - mozscreenshot == 0.1 13:16:48 INFO - mozsystemmonitor == 0.3 13:16:48 INFO - moztest == 0.7 13:16:48 INFO - mozversion == 1.4 13:16:48 INFO - psutil == 3.1.1 13:16:48 INFO - requests == 1.2.3 13:16:48 INFO - wsgiref == 0.1.2 13:16:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:16: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')]} 13:16:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:16:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:16: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')]} 13:16:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:16:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:16:48 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 0x7fbd930b2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19c18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a8e020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b202e0>, '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 0x1a8c140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a8c5d0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1465416973.972780-1410721315', '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 13:16:48 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 13:16:48 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 13:16:48 INFO - Using env: {'DISPLAY': ':0', 13:16:48 INFO - 'HOME': '/home/cltbld', 13:16:48 INFO - 'LANG': 'en_US.UTF-8', 13:16:48 INFO - 'LANGUAGE': 'en_US:en', 13:16:48 INFO - 'LOGNAME': 'cltbld', 13:16:48 INFO - 'MAIL': '/var/mail/cltbld', 13:16:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:16:48 INFO - 'MOZ_NO_REMOTE': '1', 13:16:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:16:48 INFO - 'NO_EM_RESTART': '1', 13:16:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:16:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:16:48 INFO - 'PWD': '/builds/slave/test', 13:16:48 INFO - 'SHELL': '/bin/bash', 13:16:48 INFO - 'SHLVL': '1', 13:16:48 INFO - 'TERM': 'linux', 13:16:48 INFO - 'TMOUT': '86400', 13:16:48 INFO - 'USER': 'cltbld', 13:16:48 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1465416973.972780-1410721315', 13:16:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:16:48 INFO - '_': '/tools/buildbot/bin/python'} 13:16:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:16:48 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)) 13:16:48 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)) 13:16:48 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)) 13:16:48 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)) 13:16:48 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)) 13:16:48 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)) 13:16:48 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)) 13:16:48 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)) 13:16:48 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)) 13:16:48 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)) 13:16:48 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)) 13:16:48 INFO - Cleaning up... 13:16:48 INFO - Return code: 0 13:16:48 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:16: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')]} 13:16:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:16:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:16: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')]} 13:16:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:16:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:16: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbd930b2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19c18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a8e020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b202e0>, '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 0x1a8c140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a8c5d0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1465416973.972780-1410721315', '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 13:16: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', 'jsonschema'] in /builds/slave/test/build 13:16: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 jsonschema 13:16:48 INFO - Using env: {'DISPLAY': ':0', 13:16:48 INFO - 'HOME': '/home/cltbld', 13:16:48 INFO - 'LANG': 'en_US.UTF-8', 13:16:48 INFO - 'LANGUAGE': 'en_US:en', 13:16:48 INFO - 'LOGNAME': 'cltbld', 13:16:48 INFO - 'MAIL': '/var/mail/cltbld', 13:16:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:16:48 INFO - 'MOZ_NO_REMOTE': '1', 13:16:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:16:48 INFO - 'NO_EM_RESTART': '1', 13:16:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:16:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:16:48 INFO - 'PWD': '/builds/slave/test', 13:16:48 INFO - 'SHELL': '/bin/bash', 13:16:48 INFO - 'SHLVL': '1', 13:16:48 INFO - 'TERM': 'linux', 13:16:48 INFO - 'TMOUT': '86400', 13:16:48 INFO - 'USER': 'cltbld', 13:16:48 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1465416973.972780-1410721315', 13:16:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:16:48 INFO - '_': '/tools/buildbot/bin/python'} 13:16:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:16:49 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 13:16:49 INFO - Cleaning up... 13:16:49 INFO - Return code: 0 13:16:49 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 13:16:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 13:16:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:16:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:16:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 13:16:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:16:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:16:49 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 0x7fbd930b2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19c18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a8e020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b202e0>, '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 0x1a8c140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a8c5d0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1465416973.972780-1410721315', '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 13:16:49 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 13:16:49 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 13:16:49 INFO - Using env: {'DISPLAY': ':0', 13:16:49 INFO - 'HOME': '/home/cltbld', 13:16:49 INFO - 'LANG': 'en_US.UTF-8', 13:16:49 INFO - 'LANGUAGE': 'en_US:en', 13:16:49 INFO - 'LOGNAME': 'cltbld', 13:16:49 INFO - 'MAIL': '/var/mail/cltbld', 13:16:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:16:49 INFO - 'MOZ_NO_REMOTE': '1', 13:16:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:16:49 INFO - 'NO_EM_RESTART': '1', 13:16:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:16:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:16:49 INFO - 'PWD': '/builds/slave/test', 13:16:49 INFO - 'SHELL': '/bin/bash', 13:16:49 INFO - 'SHLVL': '1', 13:16:49 INFO - 'TERM': 'linux', 13:16:49 INFO - 'TMOUT': '86400', 13:16:49 INFO - 'USER': 'cltbld', 13:16:49 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1465416973.972780-1410721315', 13:16:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:16:49 INFO - '_': '/tools/buildbot/bin/python'} 13:16:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:16:49 INFO - Downloading/unpacking flake8 13:16:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:16:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:16:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:16:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:16:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:16:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:16:51 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 13:16:51 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 13:16: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 13:16: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 13:16: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 13:16: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 13:16: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 13:16: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 13:16:51 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 13:16:51 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 13:16: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 13:16: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 13:16: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 13:16: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 13:16: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 13:16: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 13:16:51 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 13:16: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 13:16: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 13:16: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 13:16: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 13:16: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 13:16: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 13:16:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 13:16:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:16:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:16:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:16:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:16:51 INFO - no previously-included directories found matching 'docs/_build' 13:16:51 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 13:16:51 INFO - Running setup.py install for pep8 13:16:52 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:16:52 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:16:52 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:16:52 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:16:52 INFO - no previously-included directories found matching 'docs/_build' 13:16:52 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 13:16:52 INFO - Successfully installed flake8 mccabe pyflakes pep8 13:16:52 INFO - Cleaning up... 13:16:52 INFO - Return code: 0 13:16:52 INFO - Running post-action listener: _resource_record_post_action 13:16:52 INFO - Running post-action listener: _start_resource_monitoring 13:16:52 INFO - Starting resource monitoring. 13:16:52 INFO - ##### 13:16:52 INFO - ##### Finished create-virtualenv step (success) 13:16:52 INFO - ##### 13:16:52 INFO - ##### 13:16:52 INFO - ##### Running install step. 13:16:52 INFO - ##### 13:16:52 INFO - Running pre-action listener: _resource_record_pre_action 13:16:52 INFO - Running main action method: install 13:16:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:16:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:16:52 INFO - Reading from file tmpfile_stdout 13:16:52 INFO - Detecting whether we're running mozinstall >=1.0... 13:16:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:16:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:16:52 INFO - Reading from file tmpfile_stdout 13:16:52 INFO - Output received: 13:16:52 INFO - Usage: mozinstall [options] installer 13:16:52 INFO - Options: 13:16:52 INFO - -h, --help show this help message and exit 13:16:52 INFO - -d DEST, --destination=DEST 13:16:52 INFO - Directory to install application into. [default: 13:16:52 INFO - "/builds/slave/test"] 13:16:52 INFO - --app=APP Application being installed. [default: firefox] 13:16:52 INFO - mkdir: /builds/slave/test/build/application 13:16:52 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'] 13:16:52 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 13:17:08 INFO - Reading from file tmpfile_stdout 13:17:08 INFO - Output received: 13:17:08 INFO - /builds/slave/test/build/application/firefox/firefox 13:17:08 INFO - Running post-action listener: _resource_record_post_action 13:17:08 INFO - ##### 13:17:08 INFO - ##### Finished install step (success) 13:17:08 INFO - ##### 13:17:08 INFO - ##### 13:17:08 INFO - ##### Running run-tests step. 13:17:08 INFO - ##### 13:17:08 INFO - Running pre-action listener: _resource_record_pre_action 13:17:08 INFO - Running main action method: run_tests 13:17:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:17:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:17:08 INFO - Python 2.7.3 13:17:08 INFO - Return code: 0 13:17:08 INFO - grabbing minidump binary from tooltool 13:17:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 13:17:08 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 0x1b202e0>, '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 0x1a8c140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a8c5d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:17:08 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 13:17:08 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 13:17:08 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 13:17:08 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:17:08 INFO - Return code: 0 13:17:08 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 13:17:08 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:17:08 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:17:08 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 13:17:08 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:17:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 13:17:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 13:17:09 INFO - Return code: 0 13:17:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HquYGC6qQ4KjeSKvfyHVWA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-057', '--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 13:17:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/HquYGC6qQ4KjeSKvfyHVWA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-057 --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 13:17:09 INFO - Using env: {'DISPLAY': ':0', 13:17:09 INFO - 'HOME': '/home/cltbld', 13:17:09 INFO - 'LANG': 'en_US.UTF-8', 13:17:09 INFO - 'LANGUAGE': 'en_US:en', 13:17:09 INFO - 'LOGNAME': 'cltbld', 13:17:09 INFO - 'MAIL': '/var/mail/cltbld', 13:17:09 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:17:09 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:17:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:17:09 INFO - 'MOZ_NO_REMOTE': '1', 13:17:09 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:17:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:17:09 INFO - 'NO_EM_RESTART': '1', 13:17:09 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:17:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:17:09 INFO - 'PWD': '/builds/slave/test', 13:17:09 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:17:09 INFO - 'SHELL': '/bin/bash', 13:17:09 INFO - 'SHLVL': '1', 13:17:09 INFO - 'TERM': 'linux', 13:17:09 INFO - 'TMOUT': '86400', 13:17:09 INFO - 'USER': 'cltbld', 13:17:09 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1465416973.972780-1410721315', 13:17:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:17:09 INFO - '_': '/tools/buildbot/bin/python'} 13:17:09 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HquYGC6qQ4KjeSKvfyHVWA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-057', '--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 13:17:09 INFO - mozversion application_buildid: 20160608125329 13:17:09 INFO - mozversion application_changeset: ded915ec401f6690c95486a68ac2546806aa3227 13:17:09 INFO - mozversion application_display_name: Nightly 13:17:09 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:17:09 INFO - mozversion application_name: Firefox 13:17:09 INFO - mozversion application_remotingname: firefox 13:17:09 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 13:17:09 INFO - mozversion application_vendor: Mozilla 13:17:09 INFO - mozversion application_version: 50.0a1 13:17:09 INFO - mozversion platform_buildid: 20160608125329 13:17:09 INFO - mozversion platform_changeset: ded915ec401f6690c95486a68ac2546806aa3227 13:17:09 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 13:17:09 INFO - mozversion platform_version: 50.0a1 13:17:09 INFO - using testdate: 1465417029 13:17:09 INFO - actual date: 1465417029 13:17:09 INFO - starting webserver on 'localhost:48987' 13:17:09 INFO - SUITE-START | Running 2 tests 13:17:09 INFO - TEST-START | dromaeo_css 13:17:09 INFO - operating with platform_type : linux_ 13:17:09 INFO - Initialising browser for dromaeo_css test... 13:17:09 INFO - TEST-INFO | started process 3999 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpragdFF/profile http://localhost:48987/getInfo.html) 13:17:14 INFO - PROCESS | 3999 | __metrics Screen width/height:1600/1200 13:17:14 INFO - PROCESS | 3999 | colorDepth:24 13:17:14 INFO - PROCESS | 3999 | Browser inner width/height: 1024/697 13:17:14 INFO - PROCESS | 3999 | __metrics 13:17:15 ERROR - PROCESS | 3999 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 13:17:16 INFO - TEST-INFO | 3999: exit 0 13:17:16 INFO - Browser initialized. 13:17:16 INFO - Running cycle 1/1 for dromaeo_css test... 13:17:16 INFO - TEST-INFO | started process 4117 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpragdFF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:17:28 INFO - PROCESS | 4117 | RSS: Main: 168439808 13:17:28 INFO - PROCESS | 4117 | 13:18:17 INFO - PROCESS | 4117 | 1465417097897 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] 13:20:30 INFO - PROCESS | 4117 | Cycle 1(1): loaded http://localhost:48987/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48987/tests/dromaeo/cssquery-ext.html) 13:20:31 INFO - PROCESS | 4117 | RSS: Main: 169287680 13:20:31 INFO - PROCESS | 4117 | 13:23:34 INFO - PROCESS | 4117 | Cycle 1(1): loaded http://localhost:48987/tests/dromaeo/cssquery-ext.html (next: http://localhost:48987/tests/dromaeo/cssquery-jquery.html) 13:23:34 INFO - PROCESS | 4117 | RSS: Main: 169947136 13:23:34 INFO - PROCESS | 4117 | 13:26:36 INFO - PROCESS | 4117 | Cycle 1(1): loaded http://localhost:48987/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48987/tests/dromaeo/cssquery-mootools.html) 13:26:37 INFO - PROCESS | 4117 | RSS: Main: 171175936 13:26:37 INFO - PROCESS | 4117 | 13:29:39 INFO - PROCESS | 4117 | Cycle 1(1): loaded http://localhost:48987/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48987/tests/dromaeo/cssquery-prototype.html) 13:29:39 INFO - PROCESS | 4117 | RSS: Main: 169144320 13:29:39 INFO - PROCESS | 4117 | 13:32:42 INFO - PROCESS | 4117 | Cycle 1(1): loaded http://localhost:48987/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48987/tests/dromaeo/cssquery-yui.html) 13:32:43 INFO - PROCESS | 4117 | RSS: Main: 170844160 13:32:43 INFO - PROCESS | 4117 | 13:35:45 INFO - PROCESS | 4117 | Cycle 1(1): loaded http://localhost:48987/tests/dromaeo/cssquery-yui.html (next: http://localhost:48987/tests/dromaeo/cssquery-dojo.html) 13:35:46 INFO - PROCESS | 4117 | RSS: Main: 171143168 13:35:46 INFO - PROCESS | 4117 | 13:35:46 INFO - PROCESS | 4117 | __start_tp_report 13:35:46 INFO - PROCESS | 4117 | _x_x_mozilla_page_load 13:35:46 INFO - PROCESS | 4117 | _x_x_mozilla_page_load_details 13:35:46 INFO - PROCESS | 4117 | |i|pagename|runs| 13:35:46 INFO - PROCESS | 4117 | |0;dojo.html;2654.747798959099;2729.2630989632808;2746.203600955722;2746.862656867156;2756.65541807274;4767.261074533449;4836.8548943531705;4853.053654537367;4889.046635906;4967.503249675031;4743.3359329693785;4753.16819556578;4814.66297359185;4833.709977401359;4882.926756098653;4437.644988400928;4462.531434199411;4550.658700597452;4578.771061446931;4584.51862554432;4254.638355739766;4554.111948170092;4586;4624.09830083134;4648.697834640754;4365.825366985317;4448.6885917985755;4462.776861156962;4463.620592249663;4474.597286244221;4440.977795111036;4461.888452788674;4500.324951257305;4509.436320459942;4537.478190008125;4470.75410852403;4497.235469970113;4502.977485112586;4518.887027824298;4549.340345649863;4717.834875779366;4721.480637129947;4753.71477711335;4786.401699787527;4793.784279707386;5137.537621614073;5188.558972487343;5192.662476939025;5205.219217117425;5229.424763276036;5173.611979101583;5180.8963820723375;5223.399309079467;5244.763985620618;5266.631335806457;4818.204996175662;4849.709017458964;4860.270959356125;4863.537963893425;4911;5329.280547126166;5333.413324534298;5349.518543331119;5352.892942141136;5357.491038351351;5013.623978201649;5088.338515992898;5099.974500127476;5133.358330208724;5143.459936706667;5002.624803139779;5173.948260517422;5231.55531779803;5256.500632439912;5285.920711189336;5181.870453238699;5200.687958722413;5201.947980520222;5207.3490813648295;5256.448072952361;4909.214525675946;5087.567556757717;5112.437631860493;5163.7676304566385;5164.406093299319;4376.190404775127;4387.232234358974;4389.758563278986;4429.53489883564;4443.577860103285;3818.59904710007;3818.694504439638;3824.827882745283;3868.864589739346;3907.33575292201;4297.462817147856;4351.8694439166875;4417.425734654475;4436.866893993185;4487.125010622897;5288.867778305496;5298.258243845865;5302.761375738101;5335.0663633863915;5345;4452.577005184502;4515;4523.525029871882;4535.274356103007;4546.704464209815;4526;4639.559241872017;4662.137504561667;4688.812447502061;4779.545943135397;4916.975415122902;4924.581410580141;4938.901221975469;4941.703497790144;4987.775550100327;5262.26328314044;5271.393789714232;5272.7100009499845;5281.7095059770545;5288.603354748486;4774.546418090275;4840.636952228527;4841.782119804547;4875.488073752347;4890.364252647276;5101.362329708786;5137.691738495702;5140.511651393112;5142.76857541419;5187.19598462239;5053.519915608012;5203.791848326025;5204.869878252923;5215.765290561858;5220.399654039834;5052.1663925451885;5118;5125.92311115341;5146.459621739664;5178.741062946762;5089.949100508948;5136.229565565195;5156.2523434102595;5157.252198431282;5207.114790485551;4873.561379475864;4970.179920313108;5012.8496145115705;5019.32239147725;5048.747562621781;5037.5214354636255;5122.923156152586;5138.614603904647;5143.948560514496;5193.714345711022;5018.071656743514;5034.974825125851;5037.949620503748;5038.622103342337;5091.847244582668 13:35:46 INFO - PROCESS | 4117 | |1;ext.html;546.9803326983883;570.9600327977041;577.7024832211409;579.0937183308123;596.8686888884446;38201.80899095504;39410.40884386733;39519;39577.40633890494;43687.12625747491;40760;41044.58955410445;41382.37926431106;41474.58525414745;41523.58476415235;7268.164161121459;7463.888041679379;7486.962565187167;7500.5874676892745;7504.4371672124535;7679.193684663113;7789.143194248628;7795.259450352236;7807.336376408012;7810.726624568141;7752.069751629812;7762.495437796553;7788.260115289038;7813.843723125534;7843.568603726792;7650.885236721426;7725.072991241059;7793.649285782153;7829.882551761728;7846.568438735867;7671.808204794869;7726.188750181263;7753.224677532202;7769.728059517946;7784.766457006299;38250.80874595637;38951.41572876381;38985.80507097475;38987.61012389868;38999.805000975095;3074.7540196784425;3091.613548306462;3201.631812341564;3263.2494526259093;3669.7798132111893;29301.26746831325;29442.263943401373;29609.70390296091;29731.851340743375;30333.393332133455;3270.7546933980047;3273.1326198557404;3297.3075654112663;3317.336532693471;3359.1937934895695;246256.9999999982;248080;248919;249521;250662;31954;32823.17942051468;50332.74833625808;50563.74718126386;50598.482045538694;33791.155221119174;33971.32057358839;34058;34164.65835341615;34214;13783.552726963524;14084.859151408355;14128.71742565143;14195.219262940638;14215.218163001135;11250.49372778227;11576.36330001858;11603.709907252387;11618.6514404568;11639.941800290944;7856.921430785734;7869.291763741291;7874.291313781787;7967.641456134488;7968.721094761771;3120.3915236529115;3145.4809956357403;3146.7639927005566;3165.8100513969234;3220.2271454851134;856.5931182688173;858.2061593026425;889.2974550105345;913.7487191022522;934.4533447933036;27135.728642713715;28243.43513129767;28386.71613283882;28555.857220713762;28767.42465150685;964.6430820596424;965.3387429610739;978.6770365779419;1017.8320577104695;1084.6908631040117;14587.176602924634;14974.101553906583;14996.250187490581;15431.45989890371;15458.381664733284;403693;408515;409437.24502039765;410827;411801;49846;49858.75070624624;50024.74987625039;50064.749676251384;50153.49846501561;1201.9939900300617;1216.1851559455185;1218.129037738004;1233.2662066070673;1235.7034311765292;26556.336091597863;27965.440691186468;27986.86006569954;28049.29876753016;28586.85706571454;42368.788156059025;42530.5746942539;42849.571504284555;42857.57142428536;42974.785126074166;331254;332936;333239;333277;335635;25188.11841585536;25587.872060639576;25634.487310253317;25695.743042569335;26493.867530662224;40623.1875362497;40930.38604420877;41269.38095928504;41682.583174169085;41987;34830.47754283637;35146.64853351434;35188.64811351854;35253.823730882206;35590.8220458896;33713.32573348568;34054.31891362208;34170.48744268788;34789.65210347864;34914.82542587271;31316;34478.48282275718;38236.617633823305;39213.8039309813;39756.403653945796;28123.296917577223;29065.7093429063;29094.27264318324;29261.268468288465;29505.557416638338;25310.240692779247;25950;26042.21873343803;26179.214623561325;26533.336666582716 13:35:46 INFO - PROCESS | 4117 | |2;jquery.html;366.2820871092657;366.6297039989611;367.3057920530197;369.30939143801095;378.92610940866524;15876.682466350681;17185.398511052117;17457.65084698305;17646.205920733566;17666;15974.76037859433;17168.22742976566;17363.305467781305;17383;17419.477415677517;4943.159662857305;5131.948680513185;5170.793168273264;5173.6119791015635;5183.429822719517;3680.834362453683;5015.523525265094;5687.777127917497;5986.072158815369;5990.460858522732;6017.669028203447;6023.2169817923605;6044.24446944132;6055.394460553954;6063.211782468273;5110.131277682803;5460.645058071233;5469.972650136744;5532.806351777668;5545.611807173499;4648.465426475965;5308.840734777963;5332.720147164652;5353.544948679367;5358.490943360374;11630.244034137753;12152.696182595417;12160.817587736192;12246.142770006103;12285.815712764315;1741.2860727101827;1839.062078340043;1876.5496280892623;1924.3072493902184;1984.4245168901002;9205.493697846616;9211.677591284273;9544.61821527138;9590.712278631652;13130.0808943374;1687;1695.8473737363697;1714.125795844116;1723.5518765121033;1798.3705703003975;61528;64883;67681;68356.31643683549;69655.65172174107;9330.300227482965;9781.217502599775;10058.446785426726;10148.289619726696;10152.898471015344;13631.250281234627;13643.86356136426;13843.515476958259;13860.861391386159;13865;7375.852482950419;7412.18465968743;7493.550386976799;7532.811679708051;7595.354394876497;7069.646517674096;7076.610786406694;7168;7241.782746517613;7241.949917261967;4224.725392849455;4245.1934132514725;4270.210011147886;4299.462567179103;4365.628921541641;1671.4150047483527;1729.2823478256635;1808.6653969015774;1830.8352248297451;1877.1271358818215;759.5936174146805;834.678648720235;874.7463235661587;880.4409200157946;974.4737841565475;15976.840231597767;16120.919395403182;16491.83508164903;16776.832231677527;16867.156642167844;855.7561095087871;863.5509535041743;869.1569177897429;918.9494577798285;942.1097063275139;9171.427437911692;9366.11021952927;9422.764430889145;9464.858027129598;9580.95209523948;375663;378709;383827;389246;392468;78780;78876;79517.60241198757;80185.59907200544;82377.17622823695;910.0489987962595;916.9083091690911;921.944683319003;936.7236665183788;948.9620415183454;14796.630084247548;15045.699086018;15189.468368607046;15218.391264349744;15343;28940.42119157647;29618;35141;35172;36158.4576231362;47097.2935405976;47295.763521182176;49600.255996160806;49933.25100123428;50273.497265028345;7504.324610784837;7567.470277080552;7605.619719013916;7613.0483689538805;7684.193159718149;9945.880520459581;11478.82781758291;11637;11911;12308.89219970207;9501.334906556474;9706.126448619376;9750.707478775648;9976.650817221362;10229.795404091728;9951.452670103214;10093.14208292274;10290.176785857264;10307.587696492057;10349.793004139725;9697.757556061155;9889.85165222508;9892.406455612687;10106.19150467946;10320.380777153396;7540.660670269741;7569.924300756922;7581.431392645463;7625.23747625233;7722.884156737766;9298.581563829779;9995.950020249853;10203.795924081625;10215.7446063849;10351.741206469898 13:35:46 INFO - PROCESS | 4117 | |3;mootools.html;1420.3040510150026;1445.3206992713424;1524.093164567082;1693.881428300018;1712.3150739704108;6655.534112612119;7456.105267367923;7606.201348858373;8106.756797296083;8168.469049511785;7435.776926692208;7531.887021694679;7626.389888808896;7634.732784352549;7638.159802421729;2168.609650262956;2197.110170380998;2215.8670479771185;2219.533897881447;2221.888905554724;2152.4080877758665;2172.8370372222066;2195.8682479051226;2199.351191398533;2214.2250212425683;2147.3021268087855;2185.25701261571;2200.867947923122;2219.0679914435977;2265.0373591223747;2143.6891650710636;2165.9891700541552;2167.501474660829;2173.934781956536;2175.282156888223;2173.250228671106;2204.239537359608;2206.735191776981;2207.6136676081624;2216.357256395643;7659.387249020065;7693.115291741466;7737.9226207737765;7755.7673269802;7802.843943121105;4323.135372925428;4437.4009508716235;4578.496365399803;4650.279206722963;4651.162790697673;2847.757940575033;2885.5238885584063;2988.6264216972877;3029.424409362214;3043.5891154694054;944.8629948657475;969.6654654144309;971.8104969530945;977.8875429325648;990.6037584965999;10595.046445819837;10699.411532365639;10712.78574428515;10726.141908647367;10732.087772539344;4086.3257562501853;4214.262504061839;4269.615734583902;4315.482142142901;4318.330658747899;9005.684801031932;9090.36367454285;9175.587098580447;9200.539973001323;9209.539523023956;4664.766761661904;4741.241401375763;4748.121597504472;4752.049590081998;4790.233562630032;3588.7129029677562;4163.39630753539;4310.827566897352;4366.279563871925;4380.036391993756;3737.5514938207043;3737.6822970047306;3825.081980324702;3830.0999265172663;3859.3246181918053;1137.363076677047;1138.4933704501418;1155.6590805712335;1163.0288708927972;1190.892819646236;619.6065498408543;802.4423025996877;803.7161926929452;816.9959150204211;817.199144838062;5215.869603259949;5292.417834038252;5368.194770784414;5504.339479262514;5742.794013257263;832.8958880139983;841.8316336732678;874.7157173918501;876.4390789894472;922.1285884838763;3476.252605689738;3496.7727097738566;3526.259485508072;3534.3461459630053;3649.4708267301094;9582.137607615208;9902.900970990198;10021.39871607706;10022.749431264278;10039.04629060238;9685.225181985425;9740;9855.35940163887;9867.11195992364;9871.80256394868;7401.222871598512;7521.548707077593;7642.006539149987;7652.655630496641;7686.846263074707;5081.390233172043;5150.562202212704;5226.843194704165;5269.657472264444;5370.382406023201;9198.816023679623;9315.906840931504;9330.160285574331;9400.15398614128;9430.669926552539;9263.120003599648;9269.212116970133;9308.48803315824;9469.715908522756;9473.715788526355;6292;6559.27847936717;6784.118064651564;6804.591724496546;6856.691448884712;7640.235976402315;7679.654415551202;7682;7684.231576842495;7708.8843667346155;6803.693833777393;6898.827529311808;6931.792046238621;7021.68402421882;7094.503384763017;6742.561733487308;6794.218664853407;6814.897776533455;6818.965905170442;6947.3747362737595;6215.34738852414;6239.78160764371;6266.749330026931;6322.652254126067;6325.272593651789;4298.484181898192;4328.870133895988;4370.519242883217;4414.9558504414545;4420.557944205554;4538.364628951884;4625.629949604091;4643.930341044819;4657.0918670858855;4698.436187657367 13:35:46 INFO - PROCESS | 4117 | |4;prototype.html;297.51356532070065;299.53721500282063;300.8450647916322;303.67961800300685;309.0496722578073;5015.322931404259;5048.419431765344;5056.797728090876;5088.905885234673;5118.309028281181;4979.228219625955;4984.551390374865;4997.000599880021;5006.799728010875;5037.319961805155;3708.8887333379976;3767.1900541383598;3915.3164139420037;3921.8431262749455;3926.3128952433353;3855.7108216883707;3871.3805791073432;3890.727649064567;3904.4338570907203;3934.4688467057013;3903.394973779069;3904.141088960424;3907.2185562887535;3911.9608803911883;3921.1569512554797;3821.8280177392085;3867.9499865071557;3869.6517313441786;3887.3974533947003;3897.162110146318;3417.1205836789914;3418.1283772638067;3423.7432192585657;3424.510338002977;3430.6740859618294;4767.499412561666;4769.427668679746;4775.9283610745515;4781.474037855833;4790.880227994293;4437.511873693891;4445.755483448409;4479.753613551254;4484.170428470743;4490.59584637381;4933.975330123362;5230.08473517133;5249.763760630743;5257.554172602527;5275.707451674326;3578.2664553766417;3583.4087375583;3595.4786555949504;3599.6400359963795;3608.4948107265004;5437.429069947638;5446.673199607996;5452.890942181134;5477.4796394342875;5503.532199763025;3660.670539651444;3716.7212459065677;3722.8510859565313;3735.813209339522;3773.867914622975;3804.334241507725;3828.3874580067613;3836.290286297044;3836.6547010769164;3844.6539811417106;4376.6498680105515;4397.692161548661;4404.427424434803;4412.176207227377;4419.027813881005;5042.747862606855;5282.97358513205;5306.62853600252;5308.708021058879;5323.3079699639575;1302.7329397473495;1316.9793410107243;1320.4058173821627;1320.6170210638807;1323.9205647661172;775.5734346109617;820.6225136437187;841.1924552429736;842.8525008123554;861.263619605241;4416.33754936762;4554.453465584151;4562.224421848294;4566.657500687462;4567.474740404829;5407.188921661704;5457.444628281;5460.863478412992;5500.202470641734;5514.91727624086;4478.328250762412;4551.294549344857;4580.450345958507;4593.563611456906;4596.264597664358;2854.8001639885424;2866.6703329117418;2899.231703598548;2904.6659634142343;2913.2571194345305;5054.216596427486;5104.719240441811;5104.846854594368;5118.771494841286;5140.203268493389;5235.502627250406;5556.749946252428;5567.162836264023;5569.805056822992;5600.383957764642;5082.771275292621;5096.974515127475;5104.617153713486;5106.336176297058;5113.64204505681;5449.591280653887;5474;5481.588880833874;5514.724263786875;5536.861578460571;5205.479452054764;5346.759395827119;5350.8127215547265;5355.892882142413;5356.875056238077;5076.873078173076;5108.259302401057;5129.461406552258;5138.871528211825;5144;3773.603771603942;3776.754510956779;3779.884933944548;3785.962140378561;3793.6585707286476;5304.787808487617;5408.918866216931;5422.186671999231;5449.536789372948;5526.364468086061;5188.014277287303;5242.816501422432;5275.815346462856;5277.920831187612;5282;5182.926829268323;5203.245529398292;5224.660397074178;5234.816781412785;5293.550048245942;4949.277897156478;5153.201253805666;5187.507186817246;5192.636515443883;5200.193969934666;5106.821261255838;5107.540321371094;5258.7107709074835;5323.866903327448;5353.902449997819;5198.246254293182;5228.333549889508;5267.947320526746;5279;5337.252784610236 13:35:46 INFO - PROCESS | 4117 | |5;yui.html;645.2482857471045;697.5465947134362;747.6261869065468;757.7613051888658;769.3998681028797;12097.395130243485;13432.194068355906;13467.730645387086;13677.52128675494;13776.173429594231;12912.96696264299;12996.610101696964;13142.540011099614;13155.07914445989;13170;787.4645241235958;806.2018601584448;806.3750593290189;809.1180613131685;810.3476701255487;628.0986783965002;776.5767656627123;803.8834369016489;807.4953154278576;808.5189312359137;843.3421930893912;848.995755021224;849.2144766091341;850.1710831938872;851.8594431918726;842.8946381702287;845.0408786027841;845.1590667286059;845.7251393297203;848;613.0834402568189;617.7343742190856;618.5515501261594;621.59906860075;621.9067139929001;13433;13456.932715336361;13457.327133643377;13484.595462136152;13519.459221631123;13230.801537976939;13673.179609223378;13727.107737997098;13730.176189428666;13959.371828267651;9906.356086854332;10072.345297555636;10082;10292.279540432173;10365.844512332322;3288.4738441849427;3320.286138480238;3327.5674162358737;3342.4652055671218;3354.4465163248033;56394.43605563974;56428;56621.716891415694;61027.389726102614;61111.694441528394;9427.764305892408;9532.857007144898;9660.275479339078;9865.161461275871;10827.621033263798;18144.727829082574;18213.908930455527;18307.267709291744;18310.450686479428;18393.080345982646;6723.596584204964;6740.41524445521;6926.757563485254;7027.8243043923285;7061.470389720792;3702.851885924587;3796.468494410785;3821.7706937583835;3940.901477463029;3951.78265195417;2899.2172113529227;3065.1264389648845;3078.184281165493;3081.044876088375;3081.1064791210747;525.6583220906441;536.5385768239311;544.311446020784;544.5045009041753;546.7430307755349;495.8239824862122;507.83241530294913;510.10476613543733;510.6655140882728;519.3119117169765;7455.142658594223;7469.365103966115;7606.201348858401;7638.350740187147;7678.155402905676;458.8325261279676;491.961960263843;497.02334911898294;501.76667849450183;519.7037688517585;3423.3153369326233;3437.8968630941113;3496.2657841853497;3518.630543792916;3607.8376473058775;89134;89338.55330723304;90950;91423;92531.20953509407;49598.50401496011;51017.23474147891;66700;79825.60087199527;81013;45596.316055259194;55426;71317.2868271321;71459.28540714526;72114.27885721075;7065.611391373318;7149.428045756431;7158.06945097134;7305.159906610807;7336.119665640157;37461.250774984896;38188;42690.57309426866;44567.55432445634;44976.55023449854;58232.708836455546;58630;60440.697796510736;60486;60507.394926050176;11106;11148.777024459627;11273.492692828679;11299.322040677585;11342.432878355885;11646.534138634359;11848.526058957545;12092;12233.204841685618;12236.75526489483;11163.72090697739;11286.153538484483;11397.259178153394;11542.422878856192;11791;11283.887161128283;11394.601188958346;11498.885011149781;11534.307941523535;11644.88355116438;9997.400155990665;10312.896871031193;10449.843252351373;10525;10644.20168487382;9131.36080474387;9468.573914173741;9535.189508891823;9544.95227523858;9553.75223420961;9346.249379036264;9442.716718498456;9466.715998520056;9483.52582370865;9730.75673108178 13:35:46 INFO - PROCESS | 4117 | __end_tp_report 13:35:46 INFO - PROCESS | 4117 | __start_cc_report 13:35:46 INFO - PROCESS | 4117 | _x_x_mozilla_cycle_collect,407 13:35:46 INFO - PROCESS | 4117 | __end_cc_report 13:35:46 INFO - PROCESS | 4117 | __startTimestamp1465418146066__endTimestamp 13:35:46 INFO - PROCESS | 4117 | 13:35:46 INFO - PROCESS | 4117 | ------- Summary: start ------- 13:35:46 INFO - PROCESS | 4117 | Number of tests: 6 13:35:46 INFO - PROCESS | 4117 | 13:35:46 INFO - PROCESS | 4117 | [#0] dojo.html Cycles:165 Average:4812.00 Median:4924.58 stddev:508.90 (10.3%) stddev-sans-first:481.50 13:35:46 INFO - PROCESS | 4117 | Values: 2654.7 2729.3 2746.2 2746.9 2756.7 4767.3 4836.9 4853.1 4889.0 4967.5 4743.3 4753.2 4814.7 4833.7 4882.9 4437.6 4462.5 4550.7 4578.8 4584.5 4254.6 4554.1 4586.0 4624.1 4648.7 4365.8 4448.7 4462.8 4463.6 4474.6 4441.0 4461.9 4500.3 4509.4 4537.5 4470.8 4497.2 4503.0 4518.9 4549.3 4717.8 4721.5 4753.7 4786.4 4793.8 5137.5 5188.6 5192.7 5205.2 5229.4 5173.6 5180.9 5223.4 5244.8 5266.6 4818.2 4849.7 4860.3 4863.5 4911.0 5329.3 5333.4 5349.5 5352.9 5357.5 5013.6 5088.3 5100.0 5133.4 5143.5 5002.6 5173.9 5231.6 5256.5 5285.9 5181.9 5200.7 5201.9 5207.3 5256.4 4909.2 5087.6 5112.4 5163.8 5164.4 4376.2 4387.2 4389.8 4429.5 4443.6 3818.6 3818.7 3824.8 3868.9 3907.3 4297.5 4351.9 4417.4 4436.9 4487.1 5288.9 5298.3 5302.8 5335.1 5345.0 4452.6 4515.0 4523.5 4535.3 4546.7 4526.0 4639.6 4662.1 4688.8 4779.5 4917.0 4924.6 4938.9 4941.7 4987.8 5262.3 5271.4 5272.7 5281.7 5288.6 4774.5 4840.6 4841.8 4875.5 4890.4 5101.4 5137.7 5140.5 5142.8 5187.2 5053.5 5203.8 5204.9 5215.8 5220.4 5052.2 5118.0 5125.9 5146.5 5178.7 5089.9 5136.2 5156.3 5157.3 5207.1 4873.6 4970.2 5012.8 5019.3 5048.7 5037.5 5122.9 5138.6 5143.9 5193.7 5018.1 5035.0 5037.9 5038.6 5091.8 13:35:46 INFO - PROCESS | 4117 | 13:35:46 INFO - PROCESS | 4117 | [#1] ext.html Cycles:180 Average:47094.62 Median:35030.74 stddev:88997.20 (254.1%) stddev-sans-first:89178.24 13:35:46 INFO - PROCESS | 4117 | Values: 547.0 571.0 577.7 579.1 596.9 38201.8 39410.4 39519.0 39577.4 43687.1 40760.0 41044.6 41382.4 41474.6 41523.6 7268.2 7463.9 7487.0 7500.6 7504.4 7679.2 7789.1 7795.3 7807.3 7810.7 7752.1 7762.5 7788.3 7813.8 7843.6 7650.9 7725.1 7793.6 7829.9 7846.6 7671.8 7726.2 7753.2 7769.7 7784.8 38250.8 38951.4 38985.8 38987.6 38999.8 3074.8 3091.6 3201.6 3263.2 3669.8 29301.3 29442.3 29609.7 29731.9 30333.4 3270.8 3273.1 3297.3 3317.3 3359.2 246257.0 248080.0 248919.0 249521.0 250662.0 31954.0 32823.2 50332.7 50563.7 50598.5 33791.2 33971.3 34058.0 34164.7 34214.0 13783.6 14084.9 14128.7 14195.2 14215.2 11250.5 11576.4 11603.7 11618.7 11639.9 7856.9 7869.3 7874.3 7967.6 7968.7 3120.4 3145.5 3146.8 3165.8 3220.2 856.6 858.2 889.3 913.7 934.5 27135.7 28243.4 28386.7 28555.9 28767.4 964.6 965.3 978.7 1017.8 1084.7 14587.2 14974.1 14996.3 15431.5 15458.4 403693.0 408515.0 409437.2 410827.0 411801.0 49846.0 49858.8 50024.7 50064.7 50153.5 1202.0 1216.2 1218.1 1233.3 1235.7 26556.3 27965.4 27986.9 28049.3 28586.9 42368.8 42530.6 42849.6 42857.6 42974.8 331254.0 332936.0 333239.0 333277.0 335635.0 25188.1 25587.9 25634.5 25695.7 26493.9 40623.2 40930.4 41269.4 41682.6 41987.0 34830.5 35146.6 35188.6 35253.8 35590.8 33713.3 34054.3 34170.5 34789.7 34914.8 31316.0 34478.5 38236.6 39213.8 39756.4 28123.3 29065.7 29094.3 29261.3 29505.6 25310.2 25950.0 26042.2 26179.2 26533.3 13:35:46 INFO - PROCESS | 4117 | 13:35:46 INFO - PROCESS | 4117 | [#2] jquery.html Cycles:180 Average:23732.87 Median:27644.51 stddev:63455.34 (229.5%) stddev-sans-first:63609.09 13:35:46 INFO - PROCESS | 4117 | Values: 366.3 366.6 367.3 369.3 378.9 15876.7 17185.4 17457.7 17646.2 17666.0 15974.8 17168.2 17363.3 17383.0 17419.5 4943.2 5131.9 5170.8 5173.6 5183.4 3680.8 5015.5 5687.8 5986.1 5990.5 6017.7 6023.2 6044.2 6055.4 6063.2 5110.1 5460.6 5470.0 5532.8 5545.6 4648.5 5308.8 5332.7 5353.5 5358.5 11630.2 12152.7 12160.8 12246.1 12285.8 1741.3 1839.1 1876.5 1924.3 1984.4 9205.5 9211.7 9544.6 9590.7 13130.1 1687.0 1695.8 1714.1 1723.6 1798.4 61528.0 64883.0 67681.0 68356.3 69655.7 9330.3 9781.2 10058.4 10148.3 10152.9 13631.3 13643.9 13843.5 13860.9 13865.0 7375.9 7412.2 7493.6 7532.8 7595.4 7069.6 7076.6 7168.0 7241.8 7241.9 4224.7 4245.2 4270.2 4299.5 4365.6 1671.4 1729.3 1808.7 1830.8 1877.1 759.6 834.7 874.7 880.4 974.5 15976.8 16120.9 16491.8 16776.8 16867.2 855.8 863.6 869.2 918.9 942.1 9171.4 9366.1 9422.8 9464.9 9581.0 375663.0 378709.0 383827.0 389246.0 392468.0 78780.0 78876.0 79517.6 80185.6 82377.2 910.0 916.9 921.9 936.7 949.0 14796.6 15045.7 15189.5 15218.4 15343.0 28940.4 29618.0 35141.0 35172.0 36158.5 47097.3 47295.8 49600.3 49933.3 50273.5 7504.3 7567.5 7605.6 7613.0 7684.2 9945.9 11478.8 11637.0 11911.0 12308.9 9501.3 9706.1 9750.7 9976.7 10229.8 9951.5 10093.1 10290.2 10307.6 10349.8 9697.8 9889.9 9892.4 10106.2 10320.4 7540.7 7569.9 7581.4 7625.2 7722.9 9298.6 9996.0 10203.8 10215.7 10351.7 13:35:46 INFO - PROCESS | 4117 | 13:35:46 INFO - PROCESS | 4117 | [#3] mootools.html Cycles:180 Average:5194.61 Median:5221.36 stddev:2929.53 (56.1%) stddev-sans-first:2924.02 13:35:46 INFO - PROCESS | 4117 | Values: 1420.3 1445.3 1524.1 1693.9 1712.3 6655.5 7456.1 7606.2 8106.8 8168.5 7435.8 7531.9 7626.4 7634.7 7638.2 2168.6 2197.1 2215.9 2219.5 2221.9 2152.4 2172.8 2195.9 2199.4 2214.2 2147.3 2185.3 2200.9 2219.1 2265.0 2143.7 2166.0 2167.5 2173.9 2175.3 2173.3 2204.2 2206.7 2207.6 2216.4 7659.4 7693.1 7737.9 7755.8 7802.8 4323.1 4437.4 4578.5 4650.3 4651.2 2847.8 2885.5 2988.6 3029.4 3043.6 944.9 969.7 971.8 977.9 990.6 10595.0 10699.4 10712.8 10726.1 10732.1 4086.3 4214.3 4269.6 4315.5 4318.3 9005.7 9090.4 9175.6 9200.5 9209.5 4664.8 4741.2 4748.1 4752.0 4790.2 3588.7 4163.4 4310.8 4366.3 4380.0 3737.6 3737.7 3825.1 3830.1 3859.3 1137.4 1138.5 1155.7 1163.0 1190.9 619.6 802.4 803.7 817.0 817.2 5215.9 5292.4 5368.2 5504.3 5742.8 832.9 841.8 874.7 876.4 922.1 3476.3 3496.8 3526.3 3534.3 3649.5 9582.1 9902.9 10021.4 10022.7 10039.0 9685.2 9740.0 9855.4 9867.1 9871.8 7401.2 7521.5 7642.0 7652.7 7686.8 5081.4 5150.6 5226.8 5269.7 5370.4 9198.8 9315.9 9330.2 9400.2 9430.7 9263.1 9269.2 9308.5 9469.7 9473.7 6292.0 6559.3 6784.1 6804.6 6856.7 7640.2 7679.7 7682.0 7684.2 7708.9 6803.7 6898.8 6931.8 7021.7 7094.5 6742.6 6794.2 6814.9 6819.0 6947.4 6215.3 6239.8 6266.7 6322.7 6325.3 4298.5 4328.9 4370.5 4415.0 4420.6 4538.4 4625.6 4643.9 4657.1 4698.4 13:35:46 INFO - PROCESS | 4117 | 13:35:46 INFO - PROCESS | 4117 | [#4] prototype.html Cycles:180 Average:4348.91 Median:5011.06 stddev:1284.13 (25.6%) stddev-sans-first:1251.21 13:35:46 INFO - PROCESS | 4117 | Values: 297.5 299.5 300.8 303.7 309.0 5015.3 5048.4 5056.8 5088.9 5118.3 4979.2 4984.6 4997.0 5006.8 5037.3 3708.9 3767.2 3915.3 3921.8 3926.3 3855.7 3871.4 3890.7 3904.4 3934.5 3903.4 3904.1 3907.2 3912.0 3921.2 3821.8 3867.9 3869.7 3887.4 3897.2 3417.1 3418.1 3423.7 3424.5 3430.7 4767.5 4769.4 4775.9 4781.5 4790.9 4437.5 4445.8 4479.8 4484.2 4490.6 4934.0 5230.1 5249.8 5257.6 5275.7 3578.3 3583.4 3595.5 3599.6 3608.5 5437.4 5446.7 5452.9 5477.5 5503.5 3660.7 3716.7 3722.9 3735.8 3773.9 3804.3 3828.4 3836.3 3836.7 3844.7 4376.6 4397.7 4404.4 4412.2 4419.0 5042.7 5283.0 5306.6 5308.7 5323.3 1302.7 1317.0 1320.4 1320.6 1323.9 775.6 820.6 841.2 842.9 861.3 4416.3 4554.5 4562.2 4566.7 4567.5 5407.2 5457.4 5460.9 5500.2 5514.9 4478.3 4551.3 4580.5 4593.6 4596.3 2854.8 2866.7 2899.2 2904.7 2913.3 5054.2 5104.7 5104.8 5118.8 5140.2 5235.5 5556.7 5567.2 5569.8 5600.4 5082.8 5097.0 5104.6 5106.3 5113.6 5449.6 5474.0 5481.6 5514.7 5536.9 5205.5 5346.8 5350.8 5355.9 5356.9 5076.9 5108.3 5129.5 5138.9 5144.0 3773.6 3776.8 3779.9 3786.0 3793.7 5304.8 5408.9 5422.2 5449.5 5526.4 5188.0 5242.8 5275.8 5277.9 5282.0 5182.9 5203.2 5224.7 5234.8 5293.6 4949.3 5153.2 5187.5 5192.6 5200.2 5106.8 5107.5 5258.7 5323.9 5353.9 5198.2 5228.3 5267.9 5279.0 5337.3 13:35:46 INFO - PROCESS | 4117 | 13:35:46 INFO - PROCESS | 4117 | [#5] yui.html Cycles:180 Average:16328.45 Median:519.51 stddev:22552.11 (4341.1%) stddev-sans-first:22584.63 13:35:46 INFO - PROCESS | 4117 | Values: 645.2 697.5 747.6 757.8 769.4 12097.4 13432.2 13467.7 13677.5 13776.2 12913.0 12996.6 13142.5 13155.1 13170.0 787.5 806.2 806.4 809.1 810.3 628.1 776.6 803.9 807.5 808.5 843.3 849.0 849.2 850.2 851.9 842.9 845.0 845.2 845.7 848.0 613.1 617.7 618.6 621.6 621.9 13433.0 13456.9 13457.3 13484.6 13519.5 13230.8 13673.2 13727.1 13730.2 13959.4 9906.4 10072.3 10082.0 10292.3 10365.8 3288.5 3320.3 3327.6 3342.5 3354.4 56394.4 56428.0 56621.7 61027.4 61111.7 9427.8 9532.9 9660.3 9865.2 10827.6 18144.7 18213.9 18307.3 18310.5 18393.1 6723.6 6740.4 6926.8 7027.8 7061.5 3702.9 3796.5 3821.8 3940.9 3951.8 2899.2 3065.1 3078.2 3081.0 3081.1 525.7 536.5 544.3 544.5 546.7 495.8 507.8 510.1 510.7 519.3 7455.1 7469.4 7606.2 7638.4 7678.2 458.8 492.0 497.0 501.8 519.7 3423.3 3437.9 3496.3 3518.6 3607.8 89134.0 89338.6 90950.0 91423.0 92531.2 49598.5 51017.2 66700.0 79825.6 81013.0 45596.3 55426.0 71317.3 71459.3 72114.3 7065.6 7149.4 7158.1 7305.2 7336.1 37461.3 38188.0 42690.6 44567.6 44976.6 58232.7 58630.0 60440.7 60486.0 60507.4 11106.0 11148.8 11273.5 11299.3 11342.4 11646.5 11848.5 12092.0 12233.2 12236.8 11163.7 11286.2 11397.3 11542.4 11791.0 11283.9 11394.6 11498.9 11534.3 11644.9 9997.4 10312.9 10449.8 10525.0 10644.2 9131.4 9468.6 9535.2 9545.0 9553.8 9346.2 9442.7 9466.7 9483.5 9730.8 13:35:46 INFO - PROCESS | 4117 | -------- Summary: end -------- 13:35:46 INFO - PROCESS | 4117 | 13:35:46 INFO - TEST-INFO | 4117: exit 0 13:35:46 INFO - TEST-OK | dromaeo_css | took 1117165ms 13:35:46 INFO - TEST-START | kraken 13:35:46 INFO - operating with platform_type : linux_ 13:35:46 INFO - Initialising browser for kraken test... 13:35:46 INFO - TEST-INFO | started process 4346 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpo5YXJ6/profile http://localhost:48987/getInfo.html) 13:35:52 INFO - PROCESS | 4346 | __metrics Screen width/height:1600/1200 13:35:52 INFO - PROCESS | 4346 | colorDepth:24 13:35:52 INFO - PROCESS | 4346 | Browser inner width/height: 1024/697 13:35:52 INFO - PROCESS | 4346 | __metrics 13:35:52 ERROR - PROCESS | 4346 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 13:35:53 INFO - TEST-INFO | 4346: exit 0 13:35:53 INFO - Browser initialized. 13:35:53 INFO - Running cycle 1/1 for kraken test... 13:35:53 INFO - TEST-INFO | started process 4464 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpo5YXJ6/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:36:05 INFO - PROCESS | 4464 | RSS: Main: 167919616 13:36:05 INFO - PROCESS | 4464 | 13:36:08 INFO - PROCESS | 4464 | Cycle 1(1): loaded http://localhost:48987/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48987/tests/kraken/driver.html?testName=audio-beat-detection) 13:36:09 INFO - PROCESS | 4464 | RSS: Main: 173088768 13:36:09 INFO - PROCESS | 4464 | 13:36:12 INFO - PROCESS | 4464 | Cycle 1(1): loaded http://localhost:48987/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48987/tests/kraken/driver.html?testName=audio-dft) 13:36:12 INFO - PROCESS | 4464 | RSS: Main: 172703744 13:36:12 INFO - PROCESS | 4464 | 13:36:15 INFO - PROCESS | 4464 | Cycle 1(1): loaded http://localhost:48987/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48987/tests/kraken/driver.html?testName=audio-fft) 13:36:16 INFO - PROCESS | 4464 | RSS: Main: 167456768 13:36:16 INFO - PROCESS | 4464 | 13:36:18 INFO - PROCESS | 4464 | Cycle 1(1): loaded http://localhost:48987/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48987/tests/kraken/driver.html?testName=audio-oscillator) 13:36:19 INFO - PROCESS | 4464 | RSS: Main: 168239104 13:36:19 INFO - PROCESS | 4464 | 13:36:21 INFO - PROCESS | 4464 | Cycle 1(1): loaded http://localhost:48987/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48987/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:36:21 INFO - PROCESS | 4464 | RSS: Main: 168235008 13:36:21 INFO - PROCESS | 4464 | 13:36:25 INFO - PROCESS | 4464 | Cycle 1(1): loaded http://localhost:48987/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48987/tests/kraken/driver.html?testName=imaging-darkroom) 13:36:25 INFO - PROCESS | 4464 | RSS: Main: 168726528 13:36:25 INFO - PROCESS | 4464 | 13:36:29 INFO - PROCESS | 4464 | Cycle 1(1): loaded http://localhost:48987/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48987/tests/kraken/driver.html?testName=imaging-desaturate) 13:36:29 INFO - PROCESS | 4464 | RSS: Main: 166064128 13:36:29 INFO - PROCESS | 4464 | 13:36:32 INFO - PROCESS | 4464 | Cycle 1(1): loaded http://localhost:48987/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48987/tests/kraken/driver.html?testName=json-parse-financial) 13:36:33 INFO - PROCESS | 4464 | RSS: Main: 167424000 13:36:33 INFO - PROCESS | 4464 | 13:36:35 INFO - PROCESS | 4464 | Cycle 1(1): loaded http://localhost:48987/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48987/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:36:35 INFO - PROCESS | 4464 | RSS: Main: 167456768 13:36:35 INFO - PROCESS | 4464 | 13:36:37 INFO - PROCESS | 4464 | Cycle 1(1): loaded http://localhost:48987/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48987/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:36:38 INFO - PROCESS | 4464 | RSS: Main: 168042496 13:36:38 INFO - PROCESS | 4464 | 13:36:40 INFO - PROCESS | 4464 | Cycle 1(1): loaded http://localhost:48987/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48987/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:36:41 INFO - PROCESS | 4464 | RSS: Main: 168165376 13:36:41 INFO - PROCESS | 4464 | 13:36:44 INFO - PROCESS | 4464 | Cycle 1(1): loaded http://localhost:48987/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48987/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:36:44 INFO - PROCESS | 4464 | RSS: Main: 168456192 13:36:44 INFO - PROCESS | 4464 | 13:36:47 INFO - PROCESS | 4464 | Cycle 1(1): loaded http://localhost:48987/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48987/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:36:48 INFO - PROCESS | 4464 | RSS: Main: 168206336 13:36:48 INFO - PROCESS | 4464 | 13:36:49 INFO - PROCESS | 4464 | Cycle 1(1): loaded http://localhost:48987/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48987/tests/kraken/driver.html?testName=ai-astar) 13:36:50 INFO - PROCESS | 4464 | RSS: Main: 169107456 13:36:50 INFO - PROCESS | 4464 | 13:36:50 INFO - PROCESS | 4464 | __start_tp_report 13:36:50 INFO - PROCESS | 4464 | _x_x_mozilla_page_load 13:36:50 INFO - PROCESS | 4464 | _x_x_mozilla_page_load_details 13:36:50 INFO - PROCESS | 4464 | |i|pagename|runs| 13:36:50 INFO - PROCESS | 4464 | |0;ai-astar;116;109;115;115;115;114;115;113;114;113 13:36:50 INFO - PROCESS | 4464 | |1;audio-beat-detection;163;133;162;199;134;156;155;132;205;134 13:36:50 INFO - PROCESS | 4464 | |2;audio-dft;163;163;166;174;162;162;163;163;162;161 13:36:50 INFO - PROCESS | 4464 | |3;audio-fft;76;76;76;157;80;76;77;75;164;76 13:36:50 INFO - PROCESS | 4464 | |4;audio-oscillator;86;87;155;87;88;88;131;86;87;136 13:36:50 INFO - PROCESS | 4464 | |5;imaging-gaussian-blur;117;119;121;117;118;117;118;118;119;118 13:36:50 INFO - PROCESS | 4464 | |6;imaging-darkroom;148;147;148;147;146;148;149;148;147;147 13:36:50 INFO - PROCESS | 4464 | |7;imaging-desaturate;95;96;96;95;96;96;96;96;96;96 13:36:50 INFO - PROCESS | 4464 | |8;json-parse-financial;62;65;63;61;62;62;63;63;62;67 13:36:50 INFO - PROCESS | 4464 | |9;json-stringify-tinderbox;64;65;64;64;64;69;65;69;64;65 13:36:50 INFO - PROCESS | 4464 | |10;stanford-crypto-aes;91;84;86;86;87;86;87;91;120;85 13:36:50 INFO - PROCESS | 4464 | |11;stanford-crypto-ccm;150;132;132;143;144;134;145;148;135;140 13:36:50 INFO - PROCESS | 4464 | |12;stanford-crypto-pbkdf2;172;175;175;174;169;174;170;169;172;174 13:36:50 INFO - PROCESS | 4464 | |13;stanford-crypto-sha256-iterative;69;69;68;69;67;67;66;68;69;69 13:36:50 INFO - PROCESS | 4464 | __end_tp_report 13:36:50 INFO - PROCESS | 4464 | __start_cc_report 13:36:50 INFO - PROCESS | 4464 | _x_x_mozilla_cycle_collect,952 13:36:50 INFO - PROCESS | 4464 | __end_cc_report 13:36:50 INFO - PROCESS | 4464 | __startTimestamp1465418210201__endTimestamp 13:36:50 INFO - PROCESS | 4464 | 13:36:50 INFO - PROCESS | 4464 | ------- Summary: start ------- 13:36:50 INFO - PROCESS | 4464 | Number of tests: 14 13:36:50 INFO - PROCESS | 4464 | 13:36:50 INFO - PROCESS | 4464 | [#0] ai-astar Cycles:10 Average:113.90 Median:115.00 stddev:1.97 (1.7%) stddev-sans-first:1.94 13:36:50 INFO - PROCESS | 4464 | Values: 116.0 109.0 115.0 115.0 115.0 114.0 115.0 113.0 114.0 113.0 13:36:50 INFO - PROCESS | 4464 | 13:36:50 INFO - PROCESS | 4464 | [#1] audio-beat-detection Cycles:10 Average:157.30 Median:159.00 stddev:26.65 (16.8%) stddev-sans-first:28.19 13:36:50 INFO - PROCESS | 4464 | Values: 163.0 133.0 162.0 199.0 134.0 156.0 155.0 132.0 205.0 134.0 13:36:50 INFO - PROCESS | 4464 | 13:36:50 INFO - PROCESS | 4464 | [#2] audio-dft Cycles:10 Average:163.90 Median:163.00 stddev:3.78 (2.3%) stddev-sans-first:4.00 13:36:50 INFO - PROCESS | 4464 | Values: 163.0 163.0 166.0 174.0 162.0 162.0 163.0 163.0 162.0 161.0 13:36:50 INFO - PROCESS | 4464 | 13:36:50 INFO - PROCESS | 4464 | [#3] audio-fft Cycles:10 Average:93.30 Median:76.00 stddev:35.48 (46.7%) stddev-sans-first:37.08 13:36:50 INFO - PROCESS | 4464 | Values: 76.0 76.0 76.0 157.0 80.0 76.0 77.0 75.0 164.0 76.0 13:36:50 INFO - PROCESS | 4464 | 13:36:50 INFO - PROCESS | 4464 | [#4] audio-oscillator Cycles:10 Average:103.10 Median:87.00 stddev:26.61 (30.6%) stddev-sans-first:27.50 13:36:50 INFO - PROCESS | 4464 | Values: 86.0 87.0 155.0 87.0 88.0 88.0 131.0 86.0 87.0 136.0 13:36:50 INFO - PROCESS | 4464 | 13:36:50 INFO - PROCESS | 4464 | [#5] imaging-gaussian-blur Cycles:10 Average:118.20 Median:118.00 stddev:1.23 (1.0%) stddev-sans-first:1.22 13:36:50 INFO - PROCESS | 4464 | Values: 117.0 119.0 121.0 117.0 118.0 117.0 118.0 118.0 119.0 118.0 13:36:50 INFO - PROCESS | 4464 | 13:36:50 INFO - PROCESS | 4464 | [#6] imaging-darkroom Cycles:10 Average:147.50 Median:148.00 stddev:0.85 (0.6%) stddev-sans-first:0.88 13:36:50 INFO - PROCESS | 4464 | Values: 148.0 147.0 148.0 147.0 146.0 148.0 149.0 148.0 147.0 147.0 13:36:50 INFO - PROCESS | 4464 | 13:36:50 INFO - PROCESS | 4464 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 13:36:50 INFO - PROCESS | 4464 | Values: 95.0 96.0 96.0 95.0 96.0 96.0 96.0 96.0 96.0 96.0 13:36:50 INFO - PROCESS | 4464 | 13:36:50 INFO - PROCESS | 4464 | [#8] json-parse-financial Cycles:10 Average:63.00 Median:63.00 stddev:1.76 (2.8%) stddev-sans-first:1.83 13:36:50 INFO - PROCESS | 4464 | Values: 62.0 65.0 63.0 61.0 62.0 62.0 63.0 63.0 62.0 67.0 13:36:50 INFO - PROCESS | 4464 | 13:36:50 INFO - PROCESS | 4464 | [#9] json-stringify-tinderbox Cycles:10 Average:65.30 Median:65.00 stddev:2.00 (3.1%) stddev-sans-first:2.07 13:36:50 INFO - PROCESS | 4464 | Values: 64.0 65.0 64.0 64.0 64.0 69.0 65.0 69.0 64.0 65.0 13:36:50 INFO - PROCESS | 4464 | 13:36:50 INFO - PROCESS | 4464 | [#10] stanford-crypto-aes Cycles:10 Average:90.30 Median:86.50 stddev:10.69 (12.4%) stddev-sans-first:11.33 13:36:50 INFO - PROCESS | 4464 | Values: 91.0 84.0 86.0 86.0 87.0 86.0 87.0 91.0 120.0 85.0 13:36:50 INFO - PROCESS | 4464 | 13:36:50 INFO - PROCESS | 4464 | [#11] stanford-crypto-ccm Cycles:10 Average:140.30 Median:143.50 stddev:6.68 (4.7%) stddev-sans-first:6.10 13:36:50 INFO - PROCESS | 4464 | Values: 150.0 132.0 132.0 143.0 144.0 134.0 145.0 148.0 135.0 140.0 13:36:50 INFO - PROCESS | 4464 | 13:36:50 INFO - PROCESS | 4464 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.40 Median:174.00 stddev:2.37 (1.4%) stddev-sans-first:2.51 13:36:50 INFO - PROCESS | 4464 | Values: 172.0 175.0 175.0 174.0 169.0 174.0 170.0 169.0 172.0 174.0 13:36:50 INFO - PROCESS | 4464 | 13:36:50 INFO - PROCESS | 4464 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.10 Median:69.00 stddev:1.10 (1.6%) stddev-sans-first:1.12 13:36:50 INFO - PROCESS | 4464 | Values: 69.0 69.0 68.0 69.0 67.0 67.0 66.0 68.0 69.0 69.0 13:36:50 INFO - PROCESS | 4464 | -------- Summary: end -------- 13:36:50 INFO - PROCESS | 4464 | 13:36:51 INFO - TEST-INFO | 4464: exit 0 13:36:51 INFO - TEST-OK | kraken | took 64411ms 13:36:51 INFO - SUITE-END | took 1181s 13:36:51 INFO - Completed test suite (00:19:41) 13:36:51 INFO - javascript benchmark 13:36:51 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6355.642159019784, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2654.747798959099, 2729.2630989632808, 2746.203600955722, 2746.862656867156, 2756.65541807274, 4767.261074533449, 4836.8548943531705, 4853.053654537367, 4889.046635906, 4967.503249675031, 4743.3359329693785, 4753.16819556578, 4814.66297359185, 4833.709977401359, 4882.926756098653, 4437.644988400928, 4462.531434199411, 4550.658700597452, 4578.771061446931, 4584.51862554432, 4254.638355739766, 4554.111948170092, 4586.0, 4624.09830083134, 4648.697834640754, 4365.825366985317, 4448.6885917985755, 4462.776861156962, 4463.620592249663, 4474.597286244221, 4440.977795111036, 4461.888452788674, 4500.324951257305, 4509.436320459942, 4537.478190008125, 4470.75410852403, 4497.235469970113, 4502.977485112586, 4518.887027824298, 4549.340345649863, 4717.834875779366, 4721.480637129947, 4753.71477711335, 4786.401699787527, 4793.784279707386, 5137.537621614073, 5188.558972487343, 5192.662476939025, 5205.219217117425, 5229.424763276036, 5173.611979101583, 5180.8963820723375, 5223.399309079467, 5244.763985620618, 5266.631335806457, 4818.204996175662, 4849.709017458964, 4860.270959356125, 4863.537963893425, 4911.0, 5329.280547126166, 5333.413324534298, 5349.518543331119, 5352.892942141136, 5357.491038351351, 5013.623978201649, 5088.338515992898, 5099.974500127476, 5133.358330208724, 5143.459936706667, 5002.624803139779, 5173.948260517422, 5231.55531779803, 5256.500632439912, 5285.920711189336, 5181.870453238699, 5200.687958722413, 5201.947980520222, 5207.3490813648295, 5256.448072952361, 4909.214525675946, 5087.567556757717, 5112.437631860493, 5163.7676304566385, 5164.406093299319, 4376.190404775127, 4387.232234358974, 4389.758563278986, 4429.53489883564, 4443.577860103285, 3818.59904710007, 3818.694504439638, 3824.827882745283, 3868.864589739346, 3907.33575292201, 4297.462817147856, 4351.8694439166875, 4417.425734654475, 4436.866893993185, 4487.125010622897, 5288.867778305496, 5298.258243845865, 5302.761375738101, 5335.0663633863915, 5345.0, 4452.577005184502, 4515.0, 4523.525029871882, 4535.274356103007, 4546.704464209815, 4526.0, 4639.559241872017, 4662.137504561667, 4688.812447502061, 4779.545943135397, 4916.975415122902, 4924.581410580141, 4938.901221975469, 4941.703497790144, 4987.775550100327, 5262.26328314044, 5271.393789714232, 5272.7100009499845, 5281.7095059770545, 5288.603354748486, 4774.546418090275, 4840.636952228527, 4841.782119804547, 4875.488073752347, 4890.364252647276, 5101.362329708786, 5137.691738495702, 5140.511651393112, 5142.76857541419, 5187.19598462239, 5053.519915608012, 5203.791848326025, 5204.869878252923, 5215.765290561858, 5220.399654039834, 5052.1663925451885, 5118.0, 5125.92311115341, 5146.459621739664, 5178.741062946762, 5089.949100508948, 5136.229565565195, 5156.2523434102595, 5157.252198431282, 5207.114790485551, 4873.561379475864, 4970.179920313108, 5012.8496145115705, 5019.32239147725, 5048.747562621781, 5037.5214354636255, 5122.923156152586, 5138.614603904647, 5143.948560514496, 5193.714345711022, 5018.071656743514, 5034.974825125851, 5037.949620503748, 5038.622103342337, 5091.847244582668], "value": 4779.469572023457, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [546.9803326983883, 570.9600327977041, 577.7024832211409, 579.0937183308123, 596.8686888884446, 38201.80899095504, 39410.40884386733, 39519.0, 39577.40633890494, 43687.12625747491, 40760.0, 41044.58955410445, 41382.37926431106, 41474.58525414745, 41523.58476415235, 7268.164161121459, 7463.888041679379, 7486.962565187167, 7500.5874676892745, 7504.4371672124535, 7679.193684663113, 7789.143194248628, 7795.259450352236, 7807.336376408012, 7810.726624568141, 7752.069751629812, 7762.495437796553, 7788.260115289038, 7813.843723125534, 7843.568603726792, 7650.885236721426, 7725.072991241059, 7793.649285782153, 7829.882551761728, 7846.568438735867, 7671.808204794869, 7726.188750181263, 7753.224677532202, 7769.728059517946, 7784.766457006299, 38250.80874595637, 38951.41572876381, 38985.80507097475, 38987.61012389868, 38999.805000975095, 3074.7540196784425, 3091.613548306462, 3201.631812341564, 3263.2494526259093, 3669.7798132111893, 29301.26746831325, 29442.263943401373, 29609.70390296091, 29731.851340743375, 30333.393332133455, 3270.7546933980047, 3273.1326198557404, 3297.3075654112663, 3317.336532693471, 3359.1937934895695, 246256.9999999982, 248080.0, 248919.0, 249521.0, 250662.0, 31954.0, 32823.17942051468, 50332.74833625808, 50563.74718126386, 50598.482045538694, 33791.155221119174, 33971.32057358839, 34058.0, 34164.65835341615, 34214.0, 13783.552726963524, 14084.859151408355, 14128.71742565143, 14195.219262940638, 14215.218163001135, 11250.49372778227, 11576.36330001858, 11603.709907252387, 11618.6514404568, 11639.941800290944, 7856.921430785734, 7869.291763741291, 7874.291313781787, 7967.641456134488, 7968.721094761771, 3120.3915236529115, 3145.4809956357403, 3146.7639927005566, 3165.8100513969234, 3220.2271454851134, 856.5931182688173, 858.2061593026425, 889.2974550105345, 913.7487191022522, 934.4533447933036, 27135.728642713715, 28243.43513129767, 28386.71613283882, 28555.857220713762, 28767.42465150685, 964.6430820596424, 965.3387429610739, 978.6770365779419, 1017.8320577104695, 1084.6908631040117, 14587.176602924634, 14974.101553906583, 14996.250187490581, 15431.45989890371, 15458.381664733284, 403693.0, 408515.0, 409437.24502039765, 410827.0, 411801.0, 49846.0, 49858.75070624624, 50024.74987625039, 50064.749676251384, 50153.49846501561, 1201.9939900300617, 1216.1851559455185, 1218.129037738004, 1233.2662066070673, 1235.7034311765292, 26556.336091597863, 27965.440691186468, 27986.86006569954, 28049.29876753016, 28586.85706571454, 42368.788156059025, 42530.5746942539, 42849.571504284555, 42857.57142428536, 42974.785126074166, 331254.0, 332936.0, 333239.0, 333277.0, 335635.0, 25188.11841585536, 25587.872060639576, 25634.487310253317, 25695.743042569335, 26493.867530662224, 40623.1875362497, 40930.38604420877, 41269.38095928504, 41682.583174169085, 41987.0, 34830.47754283637, 35146.64853351434, 35188.64811351854, 35253.823730882206, 35590.8220458896, 33713.32573348568, 34054.31891362208, 34170.48744268788, 34789.65210347864, 34914.82542587271, 31316.0, 34478.48282275718, 38236.617633823305, 39213.8039309813, 39756.403653945796, 28123.296917577223, 29065.7093429063, 29094.27264318324, 29261.268468288465, 29505.557416638338, 25310.240692779247, 25950.0, 26042.21873343803, 26179.214623561325, 26533.336666582716], "value": 16472.552124088295, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [366.2820871092657, 366.6297039989611, 367.3057920530197, 369.30939143801095, 378.92610940866524, 15876.682466350681, 17185.398511052117, 17457.65084698305, 17646.205920733566, 17666.0, 15974.76037859433, 17168.22742976566, 17363.305467781305, 17383.0, 17419.477415677517, 4943.159662857305, 5131.948680513185, 5170.793168273264, 5173.6119791015635, 5183.429822719517, 3680.834362453683, 5015.523525265094, 5687.777127917497, 5986.072158815369, 5990.460858522732, 6017.669028203447, 6023.2169817923605, 6044.24446944132, 6055.394460553954, 6063.211782468273, 5110.131277682803, 5460.645058071233, 5469.972650136744, 5532.806351777668, 5545.611807173499, 4648.465426475965, 5308.840734777963, 5332.720147164652, 5353.544948679367, 5358.490943360374, 11630.244034137753, 12152.696182595417, 12160.817587736192, 12246.142770006103, 12285.815712764315, 1741.2860727101827, 1839.062078340043, 1876.5496280892623, 1924.3072493902184, 1984.4245168901002, 9205.493697846616, 9211.677591284273, 9544.61821527138, 9590.712278631652, 13130.0808943374, 1687.0, 1695.8473737363697, 1714.125795844116, 1723.5518765121033, 1798.3705703003975, 61528.0, 64883.0, 67681.0, 68356.31643683549, 69655.65172174107, 9330.300227482965, 9781.217502599775, 10058.446785426726, 10148.289619726696, 10152.898471015344, 13631.250281234627, 13643.86356136426, 13843.515476958259, 13860.861391386159, 13865.0, 7375.852482950419, 7412.18465968743, 7493.550386976799, 7532.811679708051, 7595.354394876497, 7069.646517674096, 7076.610786406694, 7168.0, 7241.782746517613, 7241.949917261967, 4224.725392849455, 4245.1934132514725, 4270.210011147886, 4299.462567179103, 4365.628921541641, 1671.4150047483527, 1729.2823478256635, 1808.6653969015774, 1830.8352248297451, 1877.1271358818215, 759.5936174146805, 834.678648720235, 874.7463235661587, 880.4409200157946, 974.4737841565475, 15976.840231597767, 16120.919395403182, 16491.83508164903, 16776.832231677527, 16867.156642167844, 855.7561095087871, 863.5509535041743, 869.1569177897429, 918.9494577798285, 942.1097063275139, 9171.427437911692, 9366.11021952927, 9422.764430889145, 9464.858027129598, 9580.95209523948, 375663.0, 378709.0, 383827.0, 389246.0, 392468.0, 78780.0, 78876.0, 79517.60241198757, 80185.59907200544, 82377.17622823695, 910.0489987962595, 916.9083091690911, 921.944683319003, 936.7236665183788, 948.9620415183454, 14796.630084247548, 15045.699086018, 15189.468368607046, 15218.391264349744, 15343.0, 28940.42119157647, 29618.0, 35141.0, 35172.0, 36158.4576231362, 47097.2935405976, 47295.763521182176, 49600.255996160806, 49933.25100123428, 50273.497265028345, 7504.324610784837, 7567.470277080552, 7605.619719013916, 7613.0483689538805, 7684.193159718149, 9945.880520459581, 11478.82781758291, 11637.0, 11911.0, 12308.89219970207, 9501.334906556474, 9706.126448619376, 9750.707478775648, 9976.650817221362, 10229.795404091728, 9951.452670103214, 10093.14208292274, 10290.176785857264, 10307.587696492057, 10349.793004139725, 9697.757556061155, 9889.85165222508, 9892.406455612687, 10106.19150467946, 10320.380777153396, 7540.660670269741, 7569.924300756922, 7581.431392645463, 7625.23747625233, 7722.884156737766, 9298.581563829779, 9995.950020249853, 10203.795924081625, 10215.7446063849, 10351.741206469898], "value": 8047.712624089838, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1420.3040510150026, 1445.3206992713424, 1524.093164567082, 1693.881428300018, 1712.3150739704108, 6655.534112612119, 7456.105267367923, 7606.201348858373, 8106.756797296083, 8168.469049511785, 7435.776926692208, 7531.887021694679, 7626.389888808896, 7634.732784352549, 7638.159802421729, 2168.609650262956, 2197.110170380998, 2215.8670479771185, 2219.533897881447, 2221.888905554724, 2152.4080877758665, 2172.8370372222066, 2195.8682479051226, 2199.351191398533, 2214.2250212425683, 2147.3021268087855, 2185.25701261571, 2200.867947923122, 2219.0679914435977, 2265.0373591223747, 2143.6891650710636, 2165.9891700541552, 2167.501474660829, 2173.934781956536, 2175.282156888223, 2173.250228671106, 2204.239537359608, 2206.735191776981, 2207.6136676081624, 2216.357256395643, 7659.387249020065, 7693.115291741466, 7737.9226207737765, 7755.7673269802, 7802.843943121105, 4323.135372925428, 4437.4009508716235, 4578.496365399803, 4650.279206722963, 4651.162790697673, 2847.757940575033, 2885.5238885584063, 2988.6264216972877, 3029.424409362214, 3043.5891154694054, 944.8629948657475, 969.6654654144309, 971.8104969530945, 977.8875429325648, 990.6037584965999, 10595.046445819837, 10699.411532365639, 10712.78574428515, 10726.141908647367, 10732.087772539344, 4086.3257562501853, 4214.262504061839, 4269.615734583902, 4315.482142142901, 4318.330658747899, 9005.684801031932, 9090.36367454285, 9175.587098580447, 9200.539973001323, 9209.539523023956, 4664.766761661904, 4741.241401375763, 4748.121597504472, 4752.049590081998, 4790.233562630032, 3588.7129029677562, 4163.39630753539, 4310.827566897352, 4366.279563871925, 4380.036391993756, 3737.5514938207043, 3737.6822970047306, 3825.081980324702, 3830.0999265172663, 3859.3246181918053, 1137.363076677047, 1138.4933704501418, 1155.6590805712335, 1163.0288708927972, 1190.892819646236, 619.6065498408543, 802.4423025996877, 803.7161926929452, 816.9959150204211, 817.199144838062, 5215.869603259949, 5292.417834038252, 5368.194770784414, 5504.339479262514, 5742.794013257263, 832.8958880139983, 841.8316336732678, 874.7157173918501, 876.4390789894472, 922.1285884838763, 3476.252605689738, 3496.7727097738566, 3526.259485508072, 3534.3461459630053, 3649.4708267301094, 9582.137607615208, 9902.900970990198, 10021.39871607706, 10022.749431264278, 10039.04629060238, 9685.225181985425, 9740.0, 9855.35940163887, 9867.11195992364, 9871.80256394868, 7401.222871598512, 7521.548707077593, 7642.006539149987, 7652.655630496641, 7686.846263074707, 5081.390233172043, 5150.562202212704, 5226.843194704165, 5269.657472264444, 5370.382406023201, 9198.816023679623, 9315.906840931504, 9330.160285574331, 9400.15398614128, 9430.669926552539, 9263.120003599648, 9269.212116970133, 9308.48803315824, 9469.715908522756, 9473.715788526355, 6292.0, 6559.27847936717, 6784.118064651564, 6804.591724496546, 6856.691448884712, 7640.235976402315, 7679.654415551202, 7682.0, 7684.231576842495, 7708.8843667346155, 6803.693833777393, 6898.827529311808, 6931.792046238621, 7021.68402421882, 7094.503384763017, 6742.561733487308, 6794.218664853407, 6814.897776533455, 6818.965905170442, 6947.3747362737595, 6215.34738852414, 6239.78160764371, 6266.749330026931, 6322.652254126067, 6325.272593651789, 4298.484181898192, 4328.870133895988, 4370.519242883217, 4414.9558504414545, 4420.557944205554, 4538.364628951884, 4625.629949604091, 4643.930341044819, 4657.0918670858855, 4698.436187657367], "value": 4174.271880080924, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [297.51356532070065, 299.53721500282063, 300.8450647916322, 303.67961800300685, 309.0496722578073, 5015.322931404259, 5048.419431765344, 5056.797728090876, 5088.905885234673, 5118.309028281181, 4979.228219625955, 4984.551390374865, 4997.000599880021, 5006.799728010875, 5037.319961805155, 3708.8887333379976, 3767.1900541383598, 3915.3164139420037, 3921.8431262749455, 3926.3128952433353, 3855.7108216883707, 3871.3805791073432, 3890.727649064567, 3904.4338570907203, 3934.4688467057013, 3903.394973779069, 3904.141088960424, 3907.2185562887535, 3911.9608803911883, 3921.1569512554797, 3821.8280177392085, 3867.9499865071557, 3869.6517313441786, 3887.3974533947003, 3897.162110146318, 3417.1205836789914, 3418.1283772638067, 3423.7432192585657, 3424.510338002977, 3430.6740859618294, 4767.499412561666, 4769.427668679746, 4775.9283610745515, 4781.474037855833, 4790.880227994293, 4437.511873693891, 4445.755483448409, 4479.753613551254, 4484.170428470743, 4490.59584637381, 4933.975330123362, 5230.08473517133, 5249.763760630743, 5257.554172602527, 5275.707451674326, 3578.2664553766417, 3583.4087375583, 3595.4786555949504, 3599.6400359963795, 3608.4948107265004, 5437.429069947638, 5446.673199607996, 5452.890942181134, 5477.4796394342875, 5503.532199763025, 3660.670539651444, 3716.7212459065677, 3722.8510859565313, 3735.813209339522, 3773.867914622975, 3804.334241507725, 3828.3874580067613, 3836.290286297044, 3836.6547010769164, 3844.6539811417106, 4376.6498680105515, 4397.692161548661, 4404.427424434803, 4412.176207227377, 4419.027813881005, 5042.747862606855, 5282.97358513205, 5306.62853600252, 5308.708021058879, 5323.3079699639575, 1302.7329397473495, 1316.9793410107243, 1320.4058173821627, 1320.6170210638807, 1323.9205647661172, 775.5734346109617, 820.6225136437187, 841.1924552429736, 842.8525008123554, 861.263619605241, 4416.33754936762, 4554.453465584151, 4562.224421848294, 4566.657500687462, 4567.474740404829, 5407.188921661704, 5457.444628281, 5460.863478412992, 5500.202470641734, 5514.91727624086, 4478.328250762412, 4551.294549344857, 4580.450345958507, 4593.563611456906, 4596.264597664358, 2854.8001639885424, 2866.6703329117418, 2899.231703598548, 2904.6659634142343, 2913.2571194345305, 5054.216596427486, 5104.719240441811, 5104.846854594368, 5118.771494841286, 5140.203268493389, 5235.502627250406, 5556.749946252428, 5567.162836264023, 5569.805056822992, 5600.383957764642, 5082.771275292621, 5096.974515127475, 5104.617153713486, 5106.336176297058, 5113.64204505681, 5449.591280653887, 5474.0, 5481.588880833874, 5514.724263786875, 5536.861578460571, 5205.479452054764, 5346.759395827119, 5350.8127215547265, 5355.892882142413, 5356.875056238077, 5076.873078173076, 5108.259302401057, 5129.461406552258, 5138.871528211825, 5144.0, 3773.603771603942, 3776.754510956779, 3779.884933944548, 3785.962140378561, 3793.6585707286476, 5304.787808487617, 5408.918866216931, 5422.186671999231, 5449.536789372948, 5526.364468086061, 5188.014277287303, 5242.816501422432, 5275.815346462856, 5277.920831187612, 5282.0, 5182.926829268323, 5203.245529398292, 5224.660397074178, 5234.816781412785, 5293.550048245942, 4949.277897156478, 5153.201253805666, 5187.507186817246, 5192.636515443883, 5200.193969934666, 5106.821261255838, 5107.540321371094, 5258.7107709074835, 5323.866903327448, 5353.902449997819, 5198.246254293182, 5228.333549889508, 5267.947320526746, 5279.0, 5337.252784610236], "value": 3934.0238936110572, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [645.2482857471045, 697.5465947134362, 747.6261869065468, 757.7613051888658, 769.3998681028797, 12097.395130243485, 13432.194068355906, 13467.730645387086, 13677.52128675494, 13776.173429594231, 12912.96696264299, 12996.610101696964, 13142.540011099614, 13155.07914445989, 13170.0, 787.4645241235958, 806.2018601584448, 806.3750593290189, 809.1180613131685, 810.3476701255487, 628.0986783965002, 776.5767656627123, 803.8834369016489, 807.4953154278576, 808.5189312359137, 843.3421930893912, 848.995755021224, 849.2144766091341, 850.1710831938872, 851.8594431918726, 842.8946381702287, 845.0408786027841, 845.1590667286059, 845.7251393297203, 848.0, 613.0834402568189, 617.7343742190856, 618.5515501261594, 621.59906860075, 621.9067139929001, 13433.0, 13456.932715336361, 13457.327133643377, 13484.595462136152, 13519.459221631123, 13230.801537976939, 13673.179609223378, 13727.107737997098, 13730.176189428666, 13959.371828267651, 9906.356086854332, 10072.345297555636, 10082.0, 10292.279540432173, 10365.844512332322, 3288.4738441849427, 3320.286138480238, 3327.5674162358737, 3342.4652055671218, 3354.4465163248033, 56394.43605563974, 56428.0, 56621.716891415694, 61027.389726102614, 61111.694441528394, 9427.764305892408, 9532.857007144898, 9660.275479339078, 9865.161461275871, 10827.621033263798, 18144.727829082574, 18213.908930455527, 18307.267709291744, 18310.450686479428, 18393.080345982646, 6723.596584204964, 6740.41524445521, 6926.757563485254, 7027.8243043923285, 7061.470389720792, 3702.851885924587, 3796.468494410785, 3821.7706937583835, 3940.901477463029, 3951.78265195417, 2899.2172113529227, 3065.1264389648845, 3078.184281165493, 3081.044876088375, 3081.1064791210747, 525.6583220906441, 536.5385768239311, 544.311446020784, 544.5045009041753, 546.7430307755349, 495.8239824862122, 507.83241530294913, 510.10476613543733, 510.6655140882728, 519.3119117169765, 7455.142658594223, 7469.365103966115, 7606.201348858401, 7638.350740187147, 7678.155402905676, 458.8325261279676, 491.961960263843, 497.02334911898294, 501.76667849450183, 519.7037688517585, 3423.3153369326233, 3437.8968630941113, 3496.2657841853497, 3518.630543792916, 3607.8376473058775, 89134.0, 89338.55330723304, 90950.0, 91423.0, 92531.20953509407, 49598.50401496011, 51017.23474147891, 66700.0, 79825.60087199527, 81013.0, 45596.316055259194, 55426.0, 71317.2868271321, 71459.28540714526, 72114.27885721075, 7065.611391373318, 7149.428045756431, 7158.06945097134, 7305.159906610807, 7336.119665640157, 37461.250774984896, 38188.0, 42690.57309426866, 44567.55432445634, 44976.55023449854, 58232.708836455546, 58630.0, 60440.697796510736, 60486.0, 60507.394926050176, 11106.0, 11148.777024459627, 11273.492692828679, 11299.322040677585, 11342.432878355885, 11646.534138634359, 11848.526058957545, 12092.0, 12233.204841685618, 12236.75526489483, 11163.72090697739, 11286.153538484483, 11397.259178153394, 11542.422878856192, 11791.0, 11283.887161128283, 11394.601188958346, 11498.885011149781, 11534.307941523535, 11644.88355116438, 9997.400155990665, 10312.896871031193, 10449.843252351373, 10525.0, 10644.20168487382, 9131.36080474387, 9468.573914173741, 9535.189508891823, 9544.95227523858, 9553.75223420961, 9346.249379036264, 9442.716718498456, 9466.715998520056, 9483.52582370865, 9730.75673108178], "value": 6334.052455477581, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1592.3999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 109.0, 115.0, 115.0, 115.0, 114.0, 115.0, 113.0, 114.0, 113.0], "value": 113.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 133.0, 162.0, 199.0, 134.0, 156.0, 155.0, 132.0, 205.0, 134.0], "value": 157.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 166.0, 174.0, 162.0, 162.0, 163.0, 163.0, 162.0, 161.0], "value": 163.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 76.0, 157.0, 80.0, 76.0, 77.0, 75.0, 164.0, 76.0], "value": 93.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 87.0, 155.0, 87.0, 88.0, 88.0, 131.0, 86.0, 87.0, 136.0], "value": 103.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 119.0, 121.0, 117.0, 118.0, 117.0, 118.0, 118.0, 119.0, 118.0], "value": 118.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 148.0, 147.0, 146.0, 148.0, 149.0, 148.0, 147.0, 147.0], "value": 147.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 96.0, 95.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0], "value": 95.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 65.0, 63.0, 61.0, 62.0, 62.0, 63.0, 63.0, 62.0, 67.0], "value": 63.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 64.0, 64.0, 64.0, 69.0, 65.0, 69.0, 64.0, 65.0], "value": 65.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 84.0, 86.0, 86.0, 87.0, 86.0, 87.0, 91.0, 120.0, 85.0], "value": 90.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 132.0, 132.0, 143.0, 144.0, 134.0, 145.0, 148.0, 135.0, 140.0], "value": 140.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 175.0, 175.0, 174.0, 169.0, 174.0, 170.0, 169.0, 172.0, 174.0], "value": 172.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 69.0, 68.0, 69.0, 67.0, 67.0, 66.0, 68.0, 69.0, 69.0], "value": 68.1, "unit": "score"}]}]} 13:36:51 INFO - Return code: 0 13:36:51 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 13:36:51 ERROR - # TBPL SUCCESS # 13:36:51 INFO - Running post-action listener: _resource_record_post_action 13:36:51 INFO - ##### 13:36:51 INFO - ##### Finished run-tests step (success) 13:36:51 INFO - ##### 13:36:51 INFO - Running post-run listener: _resource_record_post_run 13:36:51 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 0; Write bytes: 536215552; Read time: 0; Write time: 437540 13:36:51 INFO - TinderboxPrint: CPU usage
13.4% 13:36:51 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 13:36:51 INFO - TinderboxPrint: I/O write bytes / time
536,215,552 / 437,540 13:36:51 INFO - TinderboxPrint: CPU idle
8,283.4 (86.6%) 13:36:51 INFO - TinderboxPrint: CPU user
1,230.2 (12.9%) 13:36:51 INFO - TinderboxPrint: Swap in / out
0 / 0 13:36:51 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 238247936; Read time: 0; Write time: 229484 13:36:51 INFO - run-tests - Wall time: 1183s; CPU: 13.0%; Read bytes: 0; Write bytes: 297967616; Read time: 0; Write time: 208056 13:36:52 INFO - Running post-run listener: _upload_blobber_files 13:36:52 INFO - Blob upload gear active. 13:36:52 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:36:52 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 13:36:52 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-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 13:36:52 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-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 13:36:52 INFO - (blobuploader) - INFO - Open directory for files ... 13:36:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:36:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:36:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:36:58 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:36:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:36:58 INFO - (blobuploader) - INFO - Done attempting. 13:36:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 13:36:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:36:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:36:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 13:36:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:36:59 INFO - (blobuploader) - INFO - Done attempting. 13:36:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 13:36:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:36:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:37:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 13:37:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:37:00 INFO - (blobuploader) - INFO - Done attempting. 13:37:00 INFO - (blobuploader) - INFO - Iteration through files over. 13:37:00 INFO - Return code: 0 13:37:00 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:37:00 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:37:00 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/30dd8158745971f0df243c9adc6ccee352fece162b2cdb46ee4573a641b296a4c3acb893ef53b92ee225daf2eef840ffc3c04b3b8fca13db346a02de4d9aad36", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/19fbf4c05c4d6fdf00967970c938c9e499d36b65864f772f4f9fe8d0d225520c240def2dbfa79dd37eebbf1f40a91b5b0dacc51e5b0dbd4901aa4976a9090246", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/fda15b2a19afe7d7b7f70e51406d0a57de4f8d6362a31e8288f5b9e4bbb4cb0535f809501775f8d9211d2940fc52522529ceb4dfb0c2ca21cbb728d34b26c905"} 13:37:00 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:37:00 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:37:00 INFO - Contents: 13:37:00 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/30dd8158745971f0df243c9adc6ccee352fece162b2cdb46ee4573a641b296a4c3acb893ef53b92ee225daf2eef840ffc3c04b3b8fca13db346a02de4d9aad36", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/19fbf4c05c4d6fdf00967970c938c9e499d36b65864f772f4f9fe8d0d225520c240def2dbfa79dd37eebbf1f40a91b5b0dacc51e5b0dbd4901aa4976a9090246", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/fda15b2a19afe7d7b7f70e51406d0a57de4f8d6362a31e8288f5b9e4bbb4cb0535f809501775f8d9211d2940fc52522529ceb4dfb0c2ca21cbb728d34b26c905"} 13:37:00 INFO - Running post-run listener: copy_logs_to_upload_dir 13:37:00 INFO - Copying logs to upload dir... 13:37:00 INFO - mkdir: /builds/slave/test/build/upload/logs 13:37:00 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1243.861406 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-06-08 13:36:59.921584) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-08 13:36:59.924638) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1465416973.972780-1410721315 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-Non-PGO/sha512/30dd8158745971f0df243c9adc6ccee352fece162b2cdb46ee4573a641b296a4c3acb893ef53b92ee225daf2eef840ffc3c04b3b8fca13db346a02de4d9aad36", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/19fbf4c05c4d6fdf00967970c938c9e499d36b65864f772f4f9fe8d0d225520c240def2dbfa79dd37eebbf1f40a91b5b0dacc51e5b0dbd4901aa4976a9090246", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/fda15b2a19afe7d7b7f70e51406d0a57de4f8d6362a31e8288f5b9e4bbb4cb0535f809501775f8d9211d2940fc52522529ceb4dfb0c2ca21cbb728d34b26c905"} build_url:https://queue.taskcluster.net/v1/task/HquYGC6qQ4KjeSKvfyHVWA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011254 build_url: 'https://queue.taskcluster.net/v1/task/HquYGC6qQ4KjeSKvfyHVWA/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-Non-PGO/sha512/30dd8158745971f0df243c9adc6ccee352fece162b2cdb46ee4573a641b296a4c3acb893ef53b92ee225daf2eef840ffc3c04b3b8fca13db346a02de4d9aad36", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/19fbf4c05c4d6fdf00967970c938c9e499d36b65864f772f4f9fe8d0d225520c240def2dbfa79dd37eebbf1f40a91b5b0dacc51e5b0dbd4901aa4976a9090246", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/fda15b2a19afe7d7b7f70e51406d0a57de4f8d6362a31e8288f5b9e4bbb4cb0535f809501775f8d9211d2940fc52522529ceb4dfb0c2ca21cbb728d34b26c905"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-08 13:36:59.949737) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 13:36:59.950034) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1465416973.972780-1410721315 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004448 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 13:37:00.034671) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-08 13:37:00.035137) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-08 13:37:00.035669) ========= ========= Total master_lag: 0.18 =========