builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-005 starttime: 1465074992.78 results: success (0) buildid: 20160604113024 builduid: 411d2affbeab4cd48ded4ca2f9c99281 revision: 7556b084d9e1d24c577956325a5da126c8f480cc ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-04 14:16:32.782007) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-04 14:16:32.782426) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-04 14:16:32.783063) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-04 14:16:32.827883) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-04 14:16:32.828158) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1465074753.892088-1917207659 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-04 14:16:33-- 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% 50.9M=0s 2016-06-04 14:16:33 (50.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.116692 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-04 14:16:32.959883) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-04 14:16:32.960267) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1465074753.892088-1917207659 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014796 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-04 14:16:33.011173) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-04 14:16:33.011543) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 7556b084d9e1d24c577956325a5da126c8f480cc --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 7556b084d9e1d24c577956325a5da126c8f480cc --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=7fc86f70bae03e018da0b1d8000001c4-1465074753.892088-1917207659 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-04 14:16:34,010 truncating revision to first 12 chars 2016-06-04 14:16:34,011 Setting DEBUG logging. 2016-06-04 14:16:34,011 attempt 1/10 2016-06-04 14:16:34,011 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/7556b084d9e1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-04 14:16:34,536 unpacking tar archive at: fx-team-7556b084d9e1/testing/mozharness/ program finished with exit code 0 elapsedTime=0.847953 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-04 14:16:33.873207) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-04 14:16:33.873549) ========= script_repo_revision: 7556b084d9e1d24c577956325a5da126c8f480cc ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-04 14:16:33.874084) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-04 14:16:33.874469) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-04 14:16:33.891029) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-06-04 14:16:33.891387) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=7fc86f70bae03e018da0b1d8000001c4-1465074753.892088-1917207659 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:16:34 INFO - MultiFileLogger online at 20160604 14:16:34 in /builds/slave/test 14:16:34 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 14:16:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:16:34 INFO - {'append_to_log': False, 14:16:34 INFO - 'base_work_dir': '/builds/slave/test', 14:16:34 INFO - 'blob_upload_branch': 'Fx-Team', 14:16:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:16:34 INFO - 'branch': 'Fx-Team', 14:16:34 INFO - 'buildbot_json_path': 'buildprops.json', 14:16:34 INFO - 'config_files': ('talos/linux_config.py',), 14:16:34 INFO - 'default_actions': ('clobber', 14:16:34 INFO - 'read-buildbot-config', 14:16:34 INFO - 'download-and-extract', 14:16:34 INFO - 'populate-webroot', 14:16:34 INFO - 'create-virtualenv', 14:16:34 INFO - 'install', 14:16:34 INFO - 'run-tests'), 14:16:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:16:34 INFO - 'download_minidump_stackwalk': True, 14:16:34 INFO - 'download_symbols': 'ondemand', 14:16:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:16:34 INFO - 'tooltool.py': '/tools/tooltool.py', 14:16:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:16:34 INFO - '/tools/misc-python/virtualenv.py')}, 14:16:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:16:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:16:34 INFO - 'installer_path': 'installer.exe', 14:16:34 INFO - 'log_level': 'info', 14:16:34 INFO - 'log_name': 'talos', 14:16:34 INFO - 'log_to_console': True, 14:16:34 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:16:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:16:34 INFO - 'opt_config_files': (), 14:16:34 INFO - 'pip_index': False, 14:16:34 INFO - 'sps_profile': False, 14:16:34 INFO - 'sps_profile_interval': 0, 14:16:34 INFO - 'suite': 'dromaeojs-e10s', 14:16:34 INFO - 'system_bits': '32', 14:16:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:16:34 INFO - 'title': 'talos-linux64-ix-005', 14:16:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:16:34 INFO - 'use_talos_json': True, 14:16:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:16:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:16:34 INFO - 'work_dir': 'build'} 14:16:34 INFO - ##### 14:16:34 INFO - ##### Running clobber step. 14:16:34 INFO - ##### 14:16:34 INFO - Running pre-action listener: _resource_record_pre_action 14:16:34 INFO - Running main action method: clobber 14:16:34 INFO - rmtree: /builds/slave/test/build 14:16:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:16:35 INFO - Running post-action listener: _resource_record_post_action 14:16:35 INFO - ##### 14:16:35 INFO - ##### Finished clobber step (success) 14:16:35 INFO - ##### 14:16:35 INFO - ##### 14:16:35 INFO - ##### Running read-buildbot-config step. 14:16:35 INFO - ##### 14:16:35 INFO - Running pre-action listener: _resource_record_pre_action 14:16:35 INFO - Running main action method: read_buildbot_config 14:16:35 INFO - Using buildbot properties: 14:16:35 INFO - { 14:16:35 INFO - "project": "", 14:16:35 INFO - "product": "firefox", 14:16:35 INFO - "script_repo_revision": "production", 14:16:35 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 14:16:35 INFO - "repository": "", 14:16:35 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 14:16:35 INFO - "buildid": "20160604113024", 14:16:35 INFO - "pgo_build": "True", 14:16:35 INFO - "basedir": "/builds/slave/test", 14:16:35 INFO - "buildnumber": 531, 14:16:35 INFO - "slavename": "talos-linux64-ix-005", 14:16:35 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 14:16:35 INFO - "platform": "ubuntu64_hw", 14:16:35 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 14:16:35 INFO - "branch": "fx-team", 14:16:35 INFO - "repo_path": "integration/fx-team", 14:16:35 INFO - "revision": "7556b084d9e1d24c577956325a5da126c8f480cc", 14:16:35 INFO - "stage_platform": "linux64-pgo", 14:16:35 INFO - "builduid": "411d2affbeab4cd48ded4ca2f9c99281", 14:16:35 INFO - "slavebuilddir": "test" 14:16:35 INFO - } 14:16:35 INFO - Found installer url https://queue.taskcluster.net/v1/task/fYT15OJYTm6ZABxpOc7E4Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 14:16:35 INFO - Running post-action listener: _resource_record_post_action 14:16:35 INFO - ##### 14:16:35 INFO - ##### Finished read-buildbot-config step (success) 14:16:35 INFO - ##### 14:16:35 INFO - ##### 14:16:35 INFO - ##### Running download-and-extract step. 14:16:35 INFO - ##### 14:16:35 INFO - Running pre-action listener: _resource_record_pre_action 14:16:35 INFO - Running main action method: download_and_extract 14:16:35 INFO - mkdir: /builds/slave/test/build/tests 14: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')]} 14:16:35 INFO - https://queue.taskcluster.net/v1/task/fYT15OJYTm6ZABxpOc7E4Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 14:16:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fYT15OJYTm6ZABxpOc7E4Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 14:16:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fYT15OJYTm6ZABxpOc7E4Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 14:16:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fYT15OJYTm6ZABxpOc7E4Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 14:16:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fYT15OJYTm6ZABxpOc7E4Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 14:16:39 INFO - Downloaded 1361 bytes. 14:16:39 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 14:16:39 INFO - Using the following test package requirements: 14:16:39 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 14:16:39 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:16:39 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 14:16:39 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:16:39 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 14:16:39 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:16:39 INFO - u'jsshell-linux-x86_64.zip'], 14:16:39 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:16:39 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 14:16:39 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 14:16:39 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:16:39 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 14:16:39 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:16:39 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 14:16:39 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:16:39 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 14:16:39 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:16:39 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 14:16:39 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:16:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:16:39 INFO - https://queue.taskcluster.net/v1/task/fYT15OJYTm6ZABxpOc7E4Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:16:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fYT15OJYTm6ZABxpOc7E4Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 14:16:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fYT15OJYTm6ZABxpOc7E4Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 14:16:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fYT15OJYTm6ZABxpOc7E4Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 14:16:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fYT15OJYTm6ZABxpOc7E4Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:16:41 INFO - Downloaded 24440953 bytes. 14:16:41 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:16:41 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 14:16:42 INFO - Return code: 0 14:16:42 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 14:16:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:16:42 INFO - https://queue.taskcluster.net/v1/task/fYT15OJYTm6ZABxpOc7E4Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:16:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fYT15OJYTm6ZABxpOc7E4Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 14:16:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fYT15OJYTm6ZABxpOc7E4Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 14:16:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fYT15OJYTm6ZABxpOc7E4Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 14:16:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fYT15OJYTm6ZABxpOc7E4Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:16:44 INFO - Downloaded 24440953 bytes. 14:16:44 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:16:44 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 14:16:45 INFO - Return code: 0 14:16:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:16:45 INFO - https://queue.taskcluster.net/v1/task/fYT15OJYTm6ZABxpOc7E4Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 14:16:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fYT15OJYTm6ZABxpOc7E4Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 14:16:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fYT15OJYTm6ZABxpOc7E4Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 14:16:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fYT15OJYTm6ZABxpOc7E4Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 14:16:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fYT15OJYTm6ZABxpOc7E4Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 14:16:46 INFO - Downloaded 10833369 bytes. 14:16:46 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:16:46 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 14:16:46 INFO - Return code: 0 14:16:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:16:46 INFO - https://queue.taskcluster.net/v1/task/fYT15OJYTm6ZABxpOc7E4Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 14:16:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fYT15OJYTm6ZABxpOc7E4Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 14:16:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fYT15OJYTm6ZABxpOc7E4Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 14:16:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fYT15OJYTm6ZABxpOc7E4Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 14:16:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fYT15OJYTm6ZABxpOc7E4Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 14:16:48 INFO - Downloaded 59164279 bytes. 14:16:48 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/fYT15OJYTm6ZABxpOc7E4Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 14:16:48 INFO - mkdir: /builds/slave/test/properties 14:16:48 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:16:48 INFO - Writing to file /builds/slave/test/properties/build_url 14:16:48 INFO - Contents: 14:16:48 INFO - build_url:https://queue.taskcluster.net/v1/task/fYT15OJYTm6ZABxpOc7E4Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 14:16:49 INFO - Running post-action listener: _resource_record_post_action 14:16:49 INFO - Running post-action listener: set_extra_try_arguments 14:16:49 INFO - ##### 14:16:49 INFO - ##### Finished download-and-extract step (success) 14:16:49 INFO - ##### 14:16:49 INFO - ##### 14:16:49 INFO - ##### Running populate-webroot step. 14:16:49 INFO - ##### 14:16:49 INFO - Running pre-action listener: _resource_record_pre_action 14:16:49 INFO - Running main action method: populate_webroot 14:16:49 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:16:49 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:16:49 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:16:49 INFO - '--tppagecycles', 14:16:49 INFO - '7'], 14:16:49 INFO - 'tests': ['tsvgm']}}, 14:16:49 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:16:49 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:16:49 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:16:49 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:16:49 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:16:49 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:16:49 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:16:49 INFO - 'talos_options': ['--disable-e10s'], 14:16:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:16:49 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:16:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:16:49 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:16:49 INFO - 'talos_options': ['--disable-e10s'], 14:16:49 INFO - 'tests': ['damp', 'tps']}, 14:16:49 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:16:49 INFO - 'tests': ['damp', 'tps']}, 14:16:49 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:16:49 INFO - 'tests': ['dromaeo_dom']}, 14:16:49 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:16:49 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:16:49 INFO - 'tests': ['a11yr', 14:16:49 INFO - 'ts_paint', 14:16:49 INFO - 'tpaint', 14:16:49 INFO - 'sessionrestore', 14:16:49 INFO - 'sessionrestore_no_auto_restore', 14:16:49 INFO - 'tabpaint']}, 14:16:49 INFO - 'other-e10s': {'tests': ['a11yr', 14:16:49 INFO - 'ts_paint', 14:16:49 INFO - 'tpaint', 14:16:49 INFO - 'sessionrestore', 14:16:49 INFO - 'sessionrestore_no_auto_restore', 14:16:49 INFO - 'tabpaint']}, 14:16:49 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:16:49 INFO - 'ts_paint', 14:16:49 INFO - 'tpaint', 14:16:49 INFO - 'sessionrestore', 14:16:49 INFO - 'sessionrestore_no_auto_restore', 14:16:49 INFO - 'tabpaint']}, 14:16:49 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:16:49 INFO - 'ts_paint', 14:16:49 INFO - 'tpaint', 14:16:49 INFO - 'sessionrestore', 14:16:49 INFO - 'sessionrestore_no_auto_restore', 14:16:49 INFO - 'tabpaint']}, 14:16:49 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:16:49 INFO - 'tests': ['a11yr', 14:16:49 INFO - 'ts_paint', 14:16:49 INFO - 'tpaint', 14:16:49 INFO - 'sessionrestore', 14:16:49 INFO - 'sessionrestore_no_auto_restore', 14:16:49 INFO - 'tabpaint']}, 14:16:49 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:16:49 INFO - 'tests': ['a11yr', 14:16:49 INFO - 'ts_paint', 14:16:49 INFO - 'tpaint', 14:16:49 INFO - 'sessionrestore', 14:16:49 INFO - 'sessionrestore_no_auto_restore', 14:16:49 INFO - 'tabpaint']}, 14:16:49 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:16:49 INFO - 'tests': ['tsvgx', 14:16:49 INFO - 'tsvgr_opacity', 14:16:49 INFO - 'tart', 14:16:49 INFO - 'tscrollx', 14:16:49 INFO - 'cart']}, 14:16:49 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:16:49 INFO - 'tsvgr_opacity', 14:16:49 INFO - 'tart', 14:16:49 INFO - 'tscrollx', 14:16:49 INFO - 'cart']}, 14:16:49 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:16:49 INFO - 'talos_options': ['--disable-e10s'], 14:16:49 INFO - 'tests': ['tp5o']}, 14:16:49 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:16:49 INFO - 'tests': ['tp5o']}, 14:16:49 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:16:49 INFO - 'talos_options': ['--disable-e10s', 14:16:49 INFO - '--xperf_path', 14:16:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:16:49 INFO - 'tests': ['tp5n']}, 14:16:49 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:16:49 INFO - 'talos_options': ['--xperf_path', 14:16:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:16:49 INFO - 'tests': ['tp5n']}}, 14:16:49 INFO - 'talos.zip': {'path': '', 14:16:49 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:16:49 INFO - Running post-action listener: _resource_record_post_action 14:16:49 INFO - ##### 14:16:49 INFO - ##### Finished populate-webroot step (success) 14:16:49 INFO - ##### 14:16:49 INFO - ##### 14:16:49 INFO - ##### Running create-virtualenv step. 14:16:49 INFO - ##### 14:16:49 INFO - Running pre-action listener: _resource_record_pre_action 14:16:49 INFO - Running main action method: create_virtualenv 14:16:49 INFO - Creating virtualenv /builds/slave/test/build/venv 14:16:49 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 14:16:49 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:16:49 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:16:49 INFO - Using real prefix '/usr' 14:16:49 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:16:49 INFO - Installing distribute.............................................................................................................................................................................................done. 14:16:51 INFO - Installing pip.................done. 14:16:51 INFO - Return code: 0 14:16:51 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:16:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:16:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:16:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:16:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:16:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:16:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:16:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4c22d25f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2463190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24f5110>, '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 0x2461230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24616c0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1465074753.892088-1917207659', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:16:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 14:16:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 14:16:51 INFO - Using env: {'DISPLAY': ':0', 14:16:51 INFO - 'HOME': '/home/cltbld', 14:16:51 INFO - 'LANG': 'en_US.UTF-8', 14:16:51 INFO - 'LANGUAGE': 'en_US:en', 14:16:51 INFO - 'LOGNAME': 'cltbld', 14:16:51 INFO - 'MAIL': '/var/mail/cltbld', 14:16:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:16:51 INFO - 'MOZ_NO_REMOTE': '1', 14:16:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:16:51 INFO - 'NO_EM_RESTART': '1', 14:16:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:16:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:16:51 INFO - 'PWD': '/builds/slave/test', 14:16:51 INFO - 'SHELL': '/bin/bash', 14:16:51 INFO - 'SHLVL': '1', 14:16:51 INFO - 'TERM': 'linux', 14:16:51 INFO - 'TMOUT': '86400', 14:16:51 INFO - 'USER': 'cltbld', 14:16:51 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1465074753.892088-1917207659', 14:16:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:16:51 INFO - '_': '/tools/buildbot/bin/python'} 14:16:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:16:52 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 14:16:52 INFO - Cleaning up... 14:16:52 INFO - Return code: 0 14:16:52 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:16:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:16:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:16:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:16:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:16:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:16:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:16:52 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 0x7f4c22d25f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2463190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24f5110>, '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 0x2461230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24616c0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1465074753.892088-1917207659', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:16:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 14:16:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 14:16:52 INFO - Using env: {'DISPLAY': ':0', 14:16:52 INFO - 'HOME': '/home/cltbld', 14:16:52 INFO - 'LANG': 'en_US.UTF-8', 14:16:52 INFO - 'LANGUAGE': 'en_US:en', 14:16:52 INFO - 'LOGNAME': 'cltbld', 14:16:52 INFO - 'MAIL': '/var/mail/cltbld', 14:16:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:16:52 INFO - 'MOZ_NO_REMOTE': '1', 14:16:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:16:52 INFO - 'NO_EM_RESTART': '1', 14:16:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:16:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:16:52 INFO - 'PWD': '/builds/slave/test', 14:16:52 INFO - 'SHELL': '/bin/bash', 14:16:52 INFO - 'SHLVL': '1', 14:16:52 INFO - 'TERM': 'linux', 14:16:52 INFO - 'TMOUT': '86400', 14:16:52 INFO - 'USER': 'cltbld', 14:16:52 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1465074753.892088-1917207659', 14:16:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:16:52 INFO - '_': '/tools/buildbot/bin/python'} 14:16:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:16:52 INFO - Downloading/unpacking psutil>=3.1.1 14:16:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:16:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:16:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:16:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:16:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:16:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:16:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:16:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:16:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:16:54 INFO - Installing collected packages: psutil 14:16:54 INFO - Running setup.py install for psutil 14:16:54 INFO - building 'psutil._psutil_linux' extension 14:16:54 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 14:16:54 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 14:16:54 INFO - building 'psutil._psutil_posix' extension 14:16:54 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 14:16:54 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 14:16:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:16:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:16:54 INFO - Successfully installed psutil 14:16:54 INFO - Cleaning up... 14:16:54 INFO - Return code: 0 14:16:54 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:16:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:16:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:16:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:16:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:16:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:16:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:16:54 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 0x7f4c22d25f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2463190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24f5110>, '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 0x2461230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24616c0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1465074753.892088-1917207659', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:16:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 14:16:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 14:16:54 INFO - Using env: {'DISPLAY': ':0', 14:16:54 INFO - 'HOME': '/home/cltbld', 14:16:54 INFO - 'LANG': 'en_US.UTF-8', 14:16:54 INFO - 'LANGUAGE': 'en_US:en', 14:16:54 INFO - 'LOGNAME': 'cltbld', 14:16:54 INFO - 'MAIL': '/var/mail/cltbld', 14:16:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:16:54 INFO - 'MOZ_NO_REMOTE': '1', 14:16:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:16:54 INFO - 'NO_EM_RESTART': '1', 14:16:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:16:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:16:54 INFO - 'PWD': '/builds/slave/test', 14:16:54 INFO - 'SHELL': '/bin/bash', 14:16:54 INFO - 'SHLVL': '1', 14:16:54 INFO - 'TERM': 'linux', 14:16:54 INFO - 'TMOUT': '86400', 14:16:54 INFO - 'USER': 'cltbld', 14:16:54 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1465074753.892088-1917207659', 14:16:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:16:54 INFO - '_': '/tools/buildbot/bin/python'} 14:16:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:16:55 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:16:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:16:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:16:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:16:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:16:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:16:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:16:56 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:16:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:16:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:16:56 INFO - Installing collected packages: mozsystemmonitor 14:16:56 INFO - Running setup.py install for mozsystemmonitor 14:16:57 INFO - Successfully installed mozsystemmonitor 14:16:57 INFO - Cleaning up... 14:16:57 INFO - Return code: 0 14:16:57 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:16:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:16:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:16:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:16:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:16:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:16:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:16:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f4c22d25f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2463190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24f5110>, '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 0x2461230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24616c0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1465074753.892088-1917207659', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:16:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 14:16:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 14:16:57 INFO - Using env: {'DISPLAY': ':0', 14:16:57 INFO - 'HOME': '/home/cltbld', 14:16:57 INFO - 'LANG': 'en_US.UTF-8', 14:16:57 INFO - 'LANGUAGE': 'en_US:en', 14:16:57 INFO - 'LOGNAME': 'cltbld', 14:16:57 INFO - 'MAIL': '/var/mail/cltbld', 14:16:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:16:57 INFO - 'MOZ_NO_REMOTE': '1', 14:16:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:16:57 INFO - 'NO_EM_RESTART': '1', 14:16:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:16:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:16:57 INFO - 'PWD': '/builds/slave/test', 14:16:57 INFO - 'SHELL': '/bin/bash', 14:16:57 INFO - 'SHLVL': '1', 14:16:57 INFO - 'TERM': 'linux', 14:16:57 INFO - 'TMOUT': '86400', 14:16:57 INFO - 'USER': 'cltbld', 14:16:57 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1465074753.892088-1917207659', 14:16:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:16:57 INFO - '_': '/tools/buildbot/bin/python'} 14:16:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:16:57 INFO - Downloading/unpacking jsonschema==2.5.1 14:16:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:16:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:16:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:16:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:16:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:16:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:16:59 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:16:59 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:16:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:16:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:16:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:16:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:16:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:16:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:16:59 INFO - Downloading functools32-3.2.3-2.tar.gz 14:16:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:16:59 INFO - warning: no files found matching '*.txt' 14:16:59 INFO - no previously-included directories found matching 'build' 14:16:59 INFO - no previously-included directories found matching 'dist' 14:16:59 INFO - no previously-included directories found matching '.git*' 14:16:59 INFO - Installing collected packages: jsonschema, functools32 14:16:59 INFO - Running setup.py install for functools32 14:16:59 INFO - warning: no files found matching '*.txt' 14:16:59 INFO - no previously-included directories found matching 'build' 14:16:59 INFO - no previously-included directories found matching 'dist' 14:16:59 INFO - no previously-included directories found matching '.git*' 14:16:59 INFO - Successfully installed jsonschema functools32 14:16:59 INFO - Cleaning up... 14:16:59 INFO - Return code: 0 14:16:59 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:16:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:16:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:16:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:16:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:16:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:16:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:16:59 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 0x7f4c22d25f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2463190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24f5110>, '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 0x2461230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24616c0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1465074753.892088-1917207659', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:16:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 14:16:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 14:16:59 INFO - Using env: {'DISPLAY': ':0', 14:16:59 INFO - 'HOME': '/home/cltbld', 14:16:59 INFO - 'LANG': 'en_US.UTF-8', 14:16:59 INFO - 'LANGUAGE': 'en_US:en', 14:16:59 INFO - 'LOGNAME': 'cltbld', 14:16:59 INFO - 'MAIL': '/var/mail/cltbld', 14:16:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:16:59 INFO - 'MOZ_NO_REMOTE': '1', 14:16:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:16:59 INFO - 'NO_EM_RESTART': '1', 14:16:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:16:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:16:59 INFO - 'PWD': '/builds/slave/test', 14:16:59 INFO - 'SHELL': '/bin/bash', 14:16:59 INFO - 'SHLVL': '1', 14:16:59 INFO - 'TERM': 'linux', 14:16:59 INFO - 'TMOUT': '86400', 14:16:59 INFO - 'USER': 'cltbld', 14:16:59 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1465074753.892088-1917207659', 14:16:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:16:59 INFO - '_': '/tools/buildbot/bin/python'} 14:16:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:16:59 INFO - Downloading/unpacking blobuploader==1.2.4 14:16:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:16:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:16:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:16:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:16:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:16:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:17:01 INFO - Downloading blobuploader-1.2.4.tar.gz 14:17:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:17:01 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:17:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:17:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:17:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:17:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:17:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:17:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:17:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:17:02 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:17:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:17:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:17:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:17:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:17:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:17:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:17:02 INFO - Downloading docopt-0.6.1.tar.gz 14:17:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:17:02 INFO - Installing collected packages: blobuploader, requests, docopt 14:17:02 INFO - Running setup.py install for blobuploader 14:17:02 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:17:02 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:17:02 INFO - Running setup.py install for requests 14:17:02 INFO - Running setup.py install for docopt 14:17:03 INFO - Successfully installed blobuploader requests docopt 14:17:03 INFO - Cleaning up... 14:17:03 INFO - Return code: 0 14:17:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:17:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:17:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:17:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:17:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:17:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:17:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:17:03 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 0x7f4c22d25f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2463190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24f5110>, '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 0x2461230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24616c0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1465074753.892088-1917207659', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:17:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 14:17:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:17:03 INFO - Using env: {'DISPLAY': ':0', 14:17:03 INFO - 'HOME': '/home/cltbld', 14:17:03 INFO - 'LANG': 'en_US.UTF-8', 14:17:03 INFO - 'LANGUAGE': 'en_US:en', 14:17:03 INFO - 'LOGNAME': 'cltbld', 14:17:03 INFO - 'MAIL': '/var/mail/cltbld', 14:17:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:17:03 INFO - 'MOZ_NO_REMOTE': '1', 14:17:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:17:03 INFO - 'NO_EM_RESTART': '1', 14:17:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:17:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:17:03 INFO - 'PWD': '/builds/slave/test', 14:17:03 INFO - 'SHELL': '/bin/bash', 14:17:03 INFO - 'SHLVL': '1', 14:17:03 INFO - 'TERM': 'linux', 14:17:03 INFO - 'TMOUT': '86400', 14:17:03 INFO - 'USER': 'cltbld', 14:17:03 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1465074753.892088-1917207659', 14:17:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:17:03 INFO - '_': '/tools/buildbot/bin/python'} 14:17:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:17:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:17:03 INFO - Running setup.py (path:/tmp/pip-swewuj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:17:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:17:03 INFO - Running setup.py (path:/tmp/pip-o9qlIK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:17:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:17:03 INFO - Running setup.py (path:/tmp/pip-jUPDdi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:17:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:17:03 INFO - Running setup.py (path:/tmp/pip-8ekXJ3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:17:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:17:03 INFO - Running setup.py (path:/tmp/pip-6gcAlC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:17:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:17:03 INFO - Running setup.py (path:/tmp/pip-drVYaJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:17:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:17:03 INFO - Running setup.py (path:/tmp/pip-PIFXaz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:17:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:17:03 INFO - Running setup.py (path:/tmp/pip-0VpU1V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:17:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:17:03 INFO - Running setup.py (path:/tmp/pip-tEwV4v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:17:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:17:04 INFO - Running setup.py (path:/tmp/pip-kR_QZd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:17:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:17:04 INFO - Running setup.py (path:/tmp/pip-FYPz9R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:17:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:17:04 INFO - Running setup.py (path:/tmp/pip-KdSzUe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:17:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:17:04 INFO - Running setup.py (path:/tmp/pip-xBayNM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:17:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:17:04 INFO - Running setup.py (path:/tmp/pip-oVthjv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:17:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:17:04 INFO - Running setup.py (path:/tmp/pip-UWXN3p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:17:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:17:04 INFO - Running setup.py (path:/tmp/pip-Z_pL6W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:17:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:17:04 INFO - Running setup.py (path:/tmp/pip-Fl1d_0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:17:04 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:17:04 INFO - Running setup.py install for manifestparser 14:17:04 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:17:04 INFO - Running setup.py install for mozcrash 14:17:04 INFO - Running setup.py install for mozdebug 14:17:04 INFO - Running setup.py install for mozdevice 14:17:05 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:17:05 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:17:05 INFO - Running setup.py install for mozfile 14:17:05 INFO - Running setup.py install for mozhttpd 14:17:05 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:17:05 INFO - Running setup.py install for mozinfo 14:17:05 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:17:05 INFO - Running setup.py install for mozInstall 14:17:05 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:17:05 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:17:05 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:17:05 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:17:05 INFO - Running setup.py install for mozleak 14:17:05 INFO - Running setup.py install for mozlog 14:17:05 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:17:05 INFO - Running setup.py install for moznetwork 14:17:05 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:17:05 INFO - Running setup.py install for mozprocess 14:17:05 INFO - Running setup.py install for mozprofile 14:17:05 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:17:05 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:17:05 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:17:05 INFO - Running setup.py install for mozrunner 14:17:06 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:17:06 INFO - Running setup.py install for mozscreenshot 14:17:06 INFO - Running setup.py install for moztest 14:17:06 INFO - Running setup.py install for mozversion 14:17:06 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:17:06 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:17:06 INFO - Cleaning up... 14:17:06 INFO - Return code: 0 14:17:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:17:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:17:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:17:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:17:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:17:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:17:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:17:06 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 0x7f4c22d25f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2463190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24f5110>, '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 0x2461230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24616c0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1465074753.892088-1917207659', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:17:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 14:17:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:17:06 INFO - Using env: {'DISPLAY': ':0', 14:17:06 INFO - 'HOME': '/home/cltbld', 14:17:06 INFO - 'LANG': 'en_US.UTF-8', 14:17:06 INFO - 'LANGUAGE': 'en_US:en', 14:17:06 INFO - 'LOGNAME': 'cltbld', 14:17:06 INFO - 'MAIL': '/var/mail/cltbld', 14:17:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:17:06 INFO - 'MOZ_NO_REMOTE': '1', 14:17:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:17:06 INFO - 'NO_EM_RESTART': '1', 14:17:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:17:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:17:06 INFO - 'PWD': '/builds/slave/test', 14:17:06 INFO - 'SHELL': '/bin/bash', 14:17:06 INFO - 'SHLVL': '1', 14:17:06 INFO - 'TERM': 'linux', 14:17:06 INFO - 'TMOUT': '86400', 14:17:06 INFO - 'USER': 'cltbld', 14:17:06 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1465074753.892088-1917207659', 14:17:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:17:06 INFO - '_': '/tools/buildbot/bin/python'} 14:17:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:17:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:17:06 INFO - Running setup.py (path:/tmp/pip-hQ0zLB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:17:06 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 14:17:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:17:06 INFO - Running setup.py (path:/tmp/pip-0ppPlm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:17:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:17:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:17:06 INFO - Running setup.py (path:/tmp/pip-83AbPg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:17:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 14:17:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:17:06 INFO - Running setup.py (path:/tmp/pip-O0URYx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:17:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:17:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:17:06 INFO - Running setup.py (path:/tmp/pip-3CfmVZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:17:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 14:17:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:17:06 INFO - Running setup.py (path:/tmp/pip-bMMkln-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:17:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 14:17:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:17:07 INFO - Running setup.py (path:/tmp/pip-1_Mbqi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:17:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 14:17:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:17:07 INFO - Running setup.py (path:/tmp/pip-ThBEsP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:17:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 14:17:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:17:07 INFO - Running setup.py (path:/tmp/pip-zBsUcb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:17:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 14:17:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:17:07 INFO - Running setup.py (path:/tmp/pip-60NBqr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:17:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:17:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:17:07 INFO - Running setup.py (path:/tmp/pip-DRYRIZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:17:07 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 14:17:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:17:07 INFO - Running setup.py (path:/tmp/pip-j63EbA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:17:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 14:17:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:17:07 INFO - Running setup.py (path:/tmp/pip-J8iAsG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:17:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 14:17:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:17:07 INFO - Running setup.py (path:/tmp/pip-iYwUr1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:17:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 14:17:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:17:07 INFO - Running setup.py (path:/tmp/pip-DYRwp7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:17:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 14:17:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:17:07 INFO - Running setup.py (path:/tmp/pip-zF8AJV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:17:07 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 14:17:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:17:07 INFO - Running setup.py (path:/tmp/pip-WCsNfF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:17:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 14:17:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:17:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:17:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 14:17:07 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:17:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:17:07 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:17:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:17:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:17:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:17:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:17:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:17:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:17:09 INFO - Downloading blessings-1.6.tar.gz 14:17:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:17:09 INFO - Installing collected packages: blessings 14:17:09 INFO - Running setup.py install for blessings 14:17:09 INFO - Successfully installed blessings 14:17:09 INFO - Cleaning up... 14:17:10 INFO - Return code: 0 14:17:10 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:17:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:17:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:17:10 INFO - Reading from file tmpfile_stdout 14:17:10 INFO - Current package versions: 14:17:10 INFO - argparse == 1.2.1 14:17:10 INFO - blessings == 1.6 14:17:10 INFO - blobuploader == 1.2.4 14:17:10 INFO - docopt == 0.6.1 14:17:10 INFO - functools32 == 3.2.3-2 14:17:10 INFO - jsonschema == 2.5.1 14:17:10 INFO - manifestparser == 1.1 14:17:10 INFO - mozInstall == 1.12 14:17:10 INFO - mozcrash == 0.17 14:17:10 INFO - mozdebug == 0.1 14:17:10 INFO - mozdevice == 0.48 14:17:10 INFO - mozfile == 1.2 14:17:10 INFO - mozhttpd == 0.7 14:17:10 INFO - mozinfo == 0.9 14:17:10 INFO - mozleak == 0.1 14:17:10 INFO - mozlog == 3.2 14:17:10 INFO - moznetwork == 0.27 14:17:10 INFO - mozprocess == 0.22 14:17:10 INFO - mozprofile == 0.28 14:17:10 INFO - mozrunner == 6.11 14:17:10 INFO - mozscreenshot == 0.1 14:17:10 INFO - mozsystemmonitor == 0.3 14:17:10 INFO - moztest == 0.7 14:17:10 INFO - mozversion == 1.4 14:17:10 INFO - psutil == 3.1.1 14:17:10 INFO - requests == 1.2.3 14:17:10 INFO - wsgiref == 0.1.2 14:17:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:17:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:17:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:17:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:17:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:17:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:17:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:17:10 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 0x7f4c22d25f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2463190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24f5110>, '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 0x2461230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24616c0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1465074753.892088-1917207659', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:17:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 14:17:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:17:10 INFO - Using env: {'DISPLAY': ':0', 14:17:10 INFO - 'HOME': '/home/cltbld', 14:17:10 INFO - 'LANG': 'en_US.UTF-8', 14:17:10 INFO - 'LANGUAGE': 'en_US:en', 14:17:10 INFO - 'LOGNAME': 'cltbld', 14:17:10 INFO - 'MAIL': '/var/mail/cltbld', 14:17:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:17:10 INFO - 'MOZ_NO_REMOTE': '1', 14:17:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:17:10 INFO - 'NO_EM_RESTART': '1', 14:17:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:17:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:17:10 INFO - 'PWD': '/builds/slave/test', 14:17:10 INFO - 'SHELL': '/bin/bash', 14:17:10 INFO - 'SHLVL': '1', 14:17:10 INFO - 'TERM': 'linux', 14:17:10 INFO - 'TMOUT': '86400', 14:17:10 INFO - 'USER': 'cltbld', 14:17:10 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1465074753.892088-1917207659', 14:17:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:17:10 INFO - '_': '/tools/buildbot/bin/python'} 14:17:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:17:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 14:17:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 14:17:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 14:17:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 14:17:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 14:17:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 14:17:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 14:17:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 14:17:10 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 14:17:10 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 14:17:10 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 14:17:10 INFO - Cleaning up... 14:17:10 INFO - Return code: 0 14:17:10 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:17:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:17:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:17:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:17:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:17:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:17:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:17:10 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 0x7f4c22d25f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2463190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24f5110>, '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 0x2461230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24616c0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1465074753.892088-1917207659', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:17:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 14:17:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 14:17:10 INFO - Using env: {'DISPLAY': ':0', 14:17:10 INFO - 'HOME': '/home/cltbld', 14:17:10 INFO - 'LANG': 'en_US.UTF-8', 14:17:10 INFO - 'LANGUAGE': 'en_US:en', 14:17:10 INFO - 'LOGNAME': 'cltbld', 14:17:10 INFO - 'MAIL': '/var/mail/cltbld', 14:17:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:17:10 INFO - 'MOZ_NO_REMOTE': '1', 14:17:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:17:10 INFO - 'NO_EM_RESTART': '1', 14:17:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:17:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:17:10 INFO - 'PWD': '/builds/slave/test', 14:17:10 INFO - 'SHELL': '/bin/bash', 14:17:10 INFO - 'SHLVL': '1', 14:17:10 INFO - 'TERM': 'linux', 14:17:10 INFO - 'TMOUT': '86400', 14:17:10 INFO - 'USER': 'cltbld', 14:17:10 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1465074753.892088-1917207659', 14:17:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:17:10 INFO - '_': '/tools/buildbot/bin/python'} 14:17:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:17:10 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:17:10 INFO - Cleaning up... 14:17:10 INFO - Return code: 0 14:17:10 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 14:17:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:17:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:17:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:17:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:17:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:17:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:17:10 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 0x7f4c22d25f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2463190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24f5110>, '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 0x2461230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24616c0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1465074753.892088-1917207659', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:17:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 14:17:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 14:17:10 INFO - Using env: {'DISPLAY': ':0', 14:17:10 INFO - 'HOME': '/home/cltbld', 14:17:10 INFO - 'LANG': 'en_US.UTF-8', 14:17:10 INFO - 'LANGUAGE': 'en_US:en', 14:17:10 INFO - 'LOGNAME': 'cltbld', 14:17:10 INFO - 'MAIL': '/var/mail/cltbld', 14:17:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:17:10 INFO - 'MOZ_NO_REMOTE': '1', 14:17:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:17:10 INFO - 'NO_EM_RESTART': '1', 14:17:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:17:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:17:10 INFO - 'PWD': '/builds/slave/test', 14:17:10 INFO - 'SHELL': '/bin/bash', 14:17:10 INFO - 'SHLVL': '1', 14:17:10 INFO - 'TERM': 'linux', 14:17:10 INFO - 'TMOUT': '86400', 14:17:10 INFO - 'USER': 'cltbld', 14:17:10 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1465074753.892088-1917207659', 14:17:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:17:10 INFO - '_': '/tools/buildbot/bin/python'} 14:17:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:17:10 INFO - Downloading/unpacking flake8 14:17:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:17:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:17:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:17:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:17:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:17:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:17:12 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 14:17:12 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 14:17:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:17:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:17:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:17:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:17:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:17:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:17:13 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 14:17:13 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 14:17:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:17:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:17:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:17:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:17:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:17:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:17:13 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 14:17:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:17:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:17:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:17:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:17:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:17:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:17:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 14:17:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:17:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:17:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:17:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:17:13 INFO - no previously-included directories found matching 'docs/_build' 14:17:13 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 14:17:13 INFO - Running setup.py install for pep8 14:17:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:17:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:17:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:17:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:17:13 INFO - no previously-included directories found matching 'docs/_build' 14:17:13 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 14:17:13 INFO - Successfully installed flake8 mccabe pyflakes pep8 14:17:13 INFO - Cleaning up... 14:17:13 INFO - Return code: 0 14:17:13 INFO - Running post-action listener: _resource_record_post_action 14:17:13 INFO - Running post-action listener: _start_resource_monitoring 14:17:13 INFO - Starting resource monitoring. 14:17:13 INFO - ##### 14:17:13 INFO - ##### Finished create-virtualenv step (success) 14:17:13 INFO - ##### 14:17:13 INFO - ##### 14:17:13 INFO - ##### Running install step. 14:17:13 INFO - ##### 14:17:13 INFO - Running pre-action listener: _resource_record_pre_action 14:17:13 INFO - Running main action method: install 14:17:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:17:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:17:14 INFO - Reading from file tmpfile_stdout 14:17:14 INFO - Detecting whether we're running mozinstall >=1.0... 14:17:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:17:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:17:14 INFO - Reading from file tmpfile_stdout 14:17:14 INFO - Output received: 14:17:14 INFO - Usage: mozinstall [options] installer 14:17:14 INFO - Options: 14:17:14 INFO - -h, --help show this help message and exit 14:17:14 INFO - -d DEST, --destination=DEST 14:17:14 INFO - Directory to install application into. [default: 14:17:14 INFO - "/builds/slave/test"] 14:17:14 INFO - --app=APP Application being installed. [default: firefox] 14:17:14 INFO - mkdir: /builds/slave/test/build/application 14:17:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 14:17:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 14:17:30 INFO - Reading from file tmpfile_stdout 14:17:30 INFO - Output received: 14:17:30 INFO - /builds/slave/test/build/application/firefox/firefox 14:17:30 INFO - Running post-action listener: _resource_record_post_action 14:17:30 INFO - ##### 14:17:30 INFO - ##### Finished install step (success) 14:17:30 INFO - ##### 14:17:30 INFO - ##### 14:17:30 INFO - ##### Running run-tests step. 14:17:30 INFO - ##### 14:17:30 INFO - Running pre-action listener: _resource_record_pre_action 14:17:30 INFO - Running main action method: run_tests 14:17:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:17:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:17:30 INFO - Python 2.7.3 14:17:30 INFO - Return code: 0 14:17:30 INFO - grabbing minidump binary from tooltool 14:17: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')]} 14:17:30 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 0x24f5110>, '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 0x2461230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24616c0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:17:30 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 14:17:30 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 14:17:30 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 14:17:31 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:17:31 INFO - Return code: 0 14:17:31 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:17:31 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:17:31 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:17:31 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:17:31 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:17:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 14:17:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 14:17:31 INFO - Return code: 0 14:17:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fYT15OJYTm6ZABxpOc7E4Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-005', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 14:17:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/fYT15OJYTm6ZABxpOc7E4Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-005 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 14:17:31 INFO - Using env: {'DISPLAY': ':0', 14:17:31 INFO - 'HOME': '/home/cltbld', 14:17:31 INFO - 'LANG': 'en_US.UTF-8', 14:17:31 INFO - 'LANGUAGE': 'en_US:en', 14:17:31 INFO - 'LOGNAME': 'cltbld', 14:17:31 INFO - 'MAIL': '/var/mail/cltbld', 14:17:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:17:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:17:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:17:31 INFO - 'MOZ_NO_REMOTE': '1', 14:17:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:17:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:17:31 INFO - 'NO_EM_RESTART': '1', 14:17:31 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:17:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:17:31 INFO - 'PWD': '/builds/slave/test', 14:17:31 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:17:31 INFO - 'SHELL': '/bin/bash', 14:17:31 INFO - 'SHLVL': '1', 14:17:31 INFO - 'TERM': 'linux', 14:17:31 INFO - 'TMOUT': '86400', 14:17:31 INFO - 'USER': 'cltbld', 14:17:31 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1465074753.892088-1917207659', 14:17:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:17:31 INFO - '_': '/tools/buildbot/bin/python'} 14:17:31 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fYT15OJYTm6ZABxpOc7E4Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-005', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 14:17:32 INFO - mozversion application_buildid: 20160604113024 14:17:32 INFO - mozversion application_changeset: 7556b084d9e1d24c577956325a5da126c8f480cc 14:17:32 INFO - mozversion application_display_name: Nightly 14:17:32 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:17:32 INFO - mozversion application_name: Firefox 14:17:32 INFO - mozversion application_remotingname: firefox 14:17:32 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 14:17:32 INFO - mozversion application_vendor: Mozilla 14:17:32 INFO - mozversion application_version: 49.0a1 14:17:32 INFO - mozversion platform_buildid: 20160604113024 14:17:32 INFO - mozversion platform_changeset: 7556b084d9e1d24c577956325a5da126c8f480cc 14:17:32 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 14:17:32 INFO - mozversion platform_version: 49.0a1 14:17:32 INFO - using testdate: 1465075052 14:17:32 INFO - actual date: 1465075052 14:17:32 INFO - starting webserver on 'localhost:55346' 14:17:32 INFO - SUITE-START | Running 2 tests 14:17:32 INFO - TEST-START | dromaeo_css 14:17:32 INFO - operating with platform_type : linux_ 14:17:32 INFO - Initialising browser for dromaeo_css test... 14:17:32 INFO - TEST-INFO | started process 18386 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVWxH85/profile http://localhost:55346/getInfo.html) 14:17:36 INFO - PROCESS | 18386 | __metrics Screen width/height:1600/1200 14:17:36 INFO - PROCESS | 18386 | colorDepth:24 14:17:36 INFO - PROCESS | 18386 | Browser inner width/height: 1024/697 14:17:36 INFO - PROCESS | 18386 | __metrics 14:17:37 ERROR - PROCESS | 18386 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2938: TypeError: this.tabs is undefined 14:17:37 INFO - TEST-INFO | 18386: exit 0 14:17:37 INFO - Browser initialized. 14:17:37 INFO - Running cycle 1/1 for dromaeo_css test... 14:17:37 INFO - TEST-INFO | started process 18508 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVWxH85/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:17:49 INFO - PROCESS | 18508 | RSS: Main: 167231488 14:17:49 INFO - PROCESS | 18508 | 14:18:39 INFO - PROCESS | 18508 | 1465075119300 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 14:20:46 INFO - PROCESS | 18508 | Cycle 1(1): loaded http://localhost:55346/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55346/tests/dromaeo/cssquery-ext.html) 14:20:47 INFO - PROCESS | 18508 | RSS: Main: 171200512 14:20:47 INFO - PROCESS | 18508 | 14:23:49 INFO - PROCESS | 18508 | Cycle 1(1): loaded http://localhost:55346/tests/dromaeo/cssquery-ext.html (next: http://localhost:55346/tests/dromaeo/cssquery-jquery.html) 14:23:49 INFO - PROCESS | 18508 | RSS: Main: 170053632 14:23:49 INFO - PROCESS | 18508 | 14:26:51 INFO - PROCESS | 18508 | Cycle 1(1): loaded http://localhost:55346/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55346/tests/dromaeo/cssquery-mootools.html) 14:26:52 INFO - PROCESS | 18508 | RSS: Main: 171122688 14:26:52 INFO - PROCESS | 18508 | 14:29:54 INFO - PROCESS | 18508 | Cycle 1(1): loaded http://localhost:55346/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55346/tests/dromaeo/cssquery-prototype.html) 14:29:54 INFO - PROCESS | 18508 | RSS: Main: 168517632 14:29:54 INFO - PROCESS | 18508 | 14:32:57 INFO - PROCESS | 18508 | Cycle 1(1): loaded http://localhost:55346/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55346/tests/dromaeo/cssquery-yui.html) 14:32:57 INFO - PROCESS | 18508 | RSS: Main: 170356736 14:32:57 INFO - PROCESS | 18508 | 14:36:00 INFO - PROCESS | 18508 | Cycle 1(1): loaded http://localhost:55346/tests/dromaeo/cssquery-yui.html (next: http://localhost:55346/tests/dromaeo/cssquery-dojo.html) 14:36:00 INFO - PROCESS | 18508 | RSS: Main: 171569152 14:36:00 INFO - PROCESS | 18508 | 14:36:00 INFO - PROCESS | 18508 | __start_tp_report 14:36:00 INFO - PROCESS | 18508 | _x_x_mozilla_page_load 14:36:00 INFO - PROCESS | 18508 | _x_x_mozilla_page_load_details 14:36:00 INFO - PROCESS | 18508 | |i|pagename|runs| 14:36:00 INFO - PROCESS | 18508 | |0;dojo.html;3088.274255549946;3106.347666989932;3149.2599239178794;3174.3175217328285;3176.761742869285;5436.510714035736;5473.589480788942;5476.945230547693;5489.066858634032;5500.4499550044975;5318.76065577049;5406.189071639246;5486.204500347447;5495.258140151079;5573.804916827912;4980.128477516439;5002.849914502553;5034.924476132843;5128.4358720540895;5132.28148059272;310.11229654137895;5005.574526165262;5106.4382917879;5121.052605268019;5145.536901678848;4850.563449289563;4862.586680132175;4873.269009648563;4919.72941488218;4934.4572097069295;4933.605311575066;4944.505549445063;4947.752612369367;4957.454679985199;4998.275250088716;4870.561649451531;4888.242322440027;4917.360743103373;4929.876753081202;4951.084049450863;5299.311089558371;5365.946340536584;5373.167159090347;5390.272313237702;5396.298481197458;5784.768609255625;5794.391588883149;5794.62334948227;5801.158831969383;5850.180974663551;5734.741936612862;5744.913826292609;5757.596968212227;5780.450857168605;5817.331006934172;5427.131658934591;5439.156930675712;5440.863978400532;5444.50999410055;5461.69960652164;5828;5949.494292985059;5949.702514874239;5950.196723442323;5953.196318497034;5698.971505142447;5716.114002329562;5726;5730;5731.856703582361;5791.0734282514595;5865.35481097079;5865.794697185664;5869.911951320733;5876.588638795243;5702.8289151325525;5741.1388291756575;5830.47525722687;5839.766409343663;5858.970705146532;5730.19777231188;5773.711314434261;5790.247267855152;5794.536437085023;5826.213461182686;4311.288637374861;4311.611954924072;4312.892177695583;4321.178975994551;4331.025519258142;3795.8481660733814;3810.3141434541494;3852.5569559500454;3872.4191371294532;3881.107345310594;5344.812931547377;5470.070088085035;5493.258410114583;5573.721313934287;5606.355269144019;5740.799072032459;5827.65034097947;5834.562407819346;5834.591578589458;5885.440883116097;5537.141743029837;5553.805616803393;5567.916481252784;5574.386817450078;5578.219049333096;4781.641376896677;4829.444613869379;4887.633427492952;4948;4951.950480495149;6096.055111457731;6099.054646529795;6129.08063790435;6132.049532322497;6147.569670123138;5913.645181289136;5958.702064896651;5961.91057134152;5966.582339236212;5968.104784282305;5744.167095771007;5983.341832398346;6084.178635884276;6102.603330783485;6166.445019948226;5830.2129212555765;5850.063989761617;5853.619514731528;5854;5863.912041319469;5757.65454072757;5968.283805943314;5973.193618861572;5977.432143946318;5987.790427335022;5696.746715722535;5716.742746576498;5754.395788442321;5757.510611598061;5763;5752.395998420106;5753.626014309057;5762.884742305214;5765.682887441231;5769.278840144982;5459.754311056092;5508.44915508446;5660.122680984454;5663.32040155184;5667.036603777286;5633.746481408264;5646.7458964347525;5648.57635677334;5686.232358631697;5747.08046712524;5500.4499550044675;5531.640443371168;5539.667619942817;5548.195511650869;5566.610337276352 14:36:00 INFO - PROCESS | 18508 | |1;ext.html;585.947264746173;609.7439075588253;633.170546583975;651.2770824384935;652.7454292825798;42688.573114268846;43913.560864391344;44133.33799993002;44256.557434425646;47308.05383892329;43302.783486082524;43639.3454098188;43640.563594364045;43905.34141987873;44114.55885441144;8474.957625211866;8681.696140635078;8693.739187824376;8694.913050869474;8698.826023479527;8526.147385261485;8705.956470217672;8706.651733930636;8708.738737837875;8717;8736.781580460507;8752.299816014736;8815.294776417872;8834.955825220864;8843.557822108869;8645.783855403603;8653.956730216309;8698.130186981283;8728.345374096969;8736.213740763298;8542.829143417097;8654.09132041133;8708.869366959501;8713.259372953307;8742.650293988296;39545;39546.80226598849;39717.02829717034;39899;40010.79994600038;3405.1827561385335;3631.2555926035097;3739.3891965447165;4010.8830076675736;4237.279662457389;31123.377532449224;31360;31654.36691266162;31665.36669266602;32495.187620309443;4353.107612939371;4404.005276412038;4498.8875278117985;4544.454665440168;4571.9542804571865;293374;293817;294379;294927;295607;31045.534316985264;56872.431275686715;56987.71506142443;57066;57186;35805.641943580755;36939.07652308714;37052.62947370492;37160;37187;15022.248887555797;15083.321250543751;15143.545693629208;15181.240937953058;15202.391904323704;12726.745465090831;12740.490380384867;12794.616161515169;12799.616011519669;12810.679733006564;8289.295409890106;8353.039400468902;8359.331253499706;8383.748487545383;8521.659133634708;3000.219942814884;3022.637283525991;3042.406730687539;3046.436409264293;3064.5556394323144;1041.9270651054353;1082.5223569827128;1133.144475920691;1134.3307448605362;1158.4381574936149;31859.362812743617;32752.34495310128;32941.18823464685;33099.66900331014;33551.664483355344;1116.1223174902052;1145.3471521232984;1178.452019810792;1194.134252666827;1239.8264243005985;17487.562810929827;17515.649687006444;17678.204480798395;17741.645167096587;17750.733738993924;559246;565977;566317;567867;568336;60167.39832601706;60651.393486065455;60745;60901;60991;1346.9259190744604;1366.8496465388798;1385.7159282347295;1386.9930650346685;1392.5891861900764;32035.679643204203;32636.673633263363;32848.67151328552;32935.34129317352;33385;53480;53528.46471535235;53529;53623;53636;455777;456199;456943;457949;459410;28920.566191506725;29085.127446176648;29578.852105740196;29673.554896677;29755.702442975293;49713.751431242614;50291.497085028685;50749.74625126851;51546;51878.74060629673;41855.7907210462;42389;42607.36088958606;43418;43527.129457411305;42331.7883410581;42353.78823105865;42496;42655;42853;41818.37272440855;42590;43173.13653726845;43298.567014329456;43386.56613433825;36207.818960905024;38424.6157538421;38883.61116388913;39421;39506.60493395029;29077.854610726812;29146.7085329144;29201.85399072991;29363.119106426842;29400.11799646014 14:36:00 INFO - PROCESS | 18508 | |2;jquery.html;393.2037623811782;396.0850435494007;397.7871838566366;402.71407300816423;410.5689026522151;14915.552533423988;18256.17847196876;18553.443396698105;19712.507187320305;19949.102290396913;17642.294308227654;17835.554111147227;18092.09539523025;18261.634767304648;18264.086795660198;5357.517823395893;5555.444455554442;5604.047311956957;5606.579506537026;5731;5559.916601250984;5568.86077848053;5587.413321601234;5603.663780173182;6507.739690412378;6404.487640988733;6417.93582064178;6457.8708425831455;6461.967690161543;6476.935230647704;6235.594686345373;6388.297287298394;6390.520710946697;6444.323346048691;6455.128557644728;5639.041362968305;5644.068728659766;5644.096944488862;5660.830175094754;5698.886022279573;20609;21040.473988150417;21836.23573174931;21963.780362196332;21985.23051693199;2263.3549438409973;2377.7265614454386;2385.7017872765905;2654.9203523894316;2720.9727902720915;9863.112319891245;9867.851982220272;9874.456904870229;9974.351667141686;10283.53724082418;1931.9227230910747;1988.3239698502578;2019.3840878532042;2020.3938818354582;2028.9334888682733;83556;89970.55014724884;90023.54988225017;90656;90727;10586.153107751361;11079.667609971713;11157.72105697364;11185.272957257752;11299.830502542469;13950.790738138936;13994.720105598035;15567.922160389126;15641.608959776097;15644.608884777745;7512.0985481741445;7775;7830.295273425305;7890.526568405914;8033.437659363905;7354.595497247703;7392.334689877936;7433.331000209899;7525.134609519975;7533.397328213729;4622.815087396467;4643.8374656886845;4760.500147484534;4767.594754445841;4777.95222047782;1975.2395327798902;1989.5424052468013;1998.4004798560375;2045.7340545729257;2102.138123369442;1026.7638443158116;1027;1031.7111208861531;1082.2965072702648;1137.886211378872;18719.25122995092;19235.13441895118;19330.4200873974;19373.806261937483;19459.318923837596;1004.6182450668699;1006.5420233793752;1030.8814486334018;1033.2715435617872;1042.003914986022;10557.419341936115;10562.049415552483;10719.14246860265;10744.785104297871;10892.346459212473;466443;467001;469276;470639;471490;93002.53498732463;94270;94513;94852.52573737087;94958;1002.819492491344;1033.963811266602;1040.9323393979366;1049.6693541534391;1051.9053285204368;16615.41846035383;16949.91525042367;16970.151492425575;17058.573535661708;17343;39272.214555709295;39559.80220098881;40881.59118408778;40905.18189636131;41266.9683257921;56150.43849561452;56753.432465676466;57050.714746426005;57257;57444.42555574391;8099.392545558989;8334.20825021622;8377.58112094405;8458.788530286793;8479.576021199038;6853.040574319699;8566.48601083937;13119.08166428379;13178.80231796543;13273.336333183495;11271.605493807678;11451.885481145082;11620.418979051183;11705.590304339306;11842.230255033395;11446.713832154262;11482.655520334403;11507;11635.5927542539;11668.124890633406;11550.191486595857;11651.242669226473;11672.88327116718;11842.703932401759;12182.573609923611;8345.41582089248;8515;8581.313494920267;8581.871271931052;8602.139786021598;11672.70818229551;11866;11868.347240901834;11979.34113623759;12018.399080046138 14:36:00 INFO - PROCESS | 18508 | |3;mootools.html;1492.5298530962746;1552.441121196369;1678.5887457572896;1798.1189217283536;1818.618090201057;7876.448648594601;8622.698205562807;8656.913430865698;9240.537973101344;9258.861117083241;8907.242884354837;9162.083791620835;9233.261339092873;9238.260939124872;9254.67608633698;2333.8482998605077;2357.068957761683;2373.8100951923893;2378.8691621960784;2380.4048987753063;2298.10373954158;2334.1013709721797;2335.1359996801207;2348.43637526994;2349.3539276698875;2247.797698207161;2251.2120757734824;2257.638777795553;2276.4877902471894;2277.635578307471;2275.82931280153;2301.6777651128855;2304.5045315257216;2309.872956987365;2311.179531266393;2245.8091062259728;2288.164819840746;2320.7215134184007;2321.3848330192513;2332.5568142052957;9053.958794738623;9066.77333066672;9164.95417522908;9169.862452063224;9175.632974681004;5064.063148317537;5175.534201921845;5180.222966555009;5215.295935048795;5223.294855194538;3266.265090354675;3356.5153020474045;3422.828858557087;3466.9306613867834;3479.878204262864;1120.4005856866618;1139.8233273842484;2196.3191410662744;2217.390217690132;2267.115824828318;12943.741125177443;13023.413946372437;13073.15024523403;13082.345882705922;13144.277064761434;4421.3861940391525;4428.800703968329;4477.485089214782;4482.103579284156;4562.24722920721;10271.229657775697;10325.225608079425;10331.22515811302;10343.741406464898;10347.741306467247;5109.105906466353;5230.843074707765;5237.3453318335205;5270.92093618596;5278.524932755993;4221.598948099926;4854.708717476963;4860.125177468019;4969.2546118081855;4988.72562009093;3911.726179167431;3917.4319723639915;3978.0850404407147;4025.1144748155357;4026.939595906064;1117.5082963496036;1120.4733775125678;1122.6575894352302;1138.7893239750672;1146.415328182633;865.4936861935838;940.1773448232797;954.9972528844685;972.781124247053;982.7002764157;5937.34689184198;5945.583809133319;5959.910601340984;5974.850628734316;5988.700564971821;450.2435907675137;455.0534887434129;456.68032377336;458.06783196195585;467.1870944556515;3952.3676211805973;3991.820368083443;4034.3141665916864;4043.939340909889;4055.148418832019;11320;11689.357085360387;11705.824412633818;11734;11754.88245117555;11578.71053223676;11582.710432239093;11613.30320180792;11616.825747613793;11617;8128.512289262663;8559.914400856036;8612.052674205832;8674.522901240493;8694.347923905732;5716.3140423147825;5922.407759224216;6101.816945491642;6105.511559075175;6110.052941794029;9928.950355248466;10321.948390258001;10333.431661258403;10429.9478502607;10450.111740501838;10063.647772327933;10379.740506487398;10505.789884202426;10673.252872299176;10689.679309620724;7509.774706758588;7909.960450197942;8064.919350806417;8339.291160251447;8461.61922713467;8908.955455222682;8910.55447227623;8940.284777217938;8940.910590894007;8951.552422378725;7776.766696999099;7971.511841882866;8139.511629302024;8218.630161642861;8218.917810821815;7852.882206767017;7932;8023.4784738991775;8109.837803243784;8119.350451963711;6857.245702972768;6909.792706218822;6977.197622273504;6990.510664253657;7113.110861142357;5099.986578982787;5108.770105345194;5111.514406131411;5128.1794912813775;5278.023565640369;5108.59131269505;5127.769250383816;5222.425533191422;5234.084035293885;5313.574914006947 14:36:00 INFO - PROCESS | 18508 | |4;prototype.html;308.48175065889296;311.3042350346974;317.1943264109163;321.72331794656577;332.03212635168484;5530.695811730353;5574.916376254359;5713.571482138841;5755.884882302356;5783.219265399175;5569.972150139254;5635.6618602883855;5635.774569017234;5639.379668236491;5642.689652069134;4412.691111622188;4421.911561768763;4435.955640443586;4441.111777644484;4442.466903971512;4349.956500434987;4356.869293921171;4378.978105109486;4434.889127771799;4447.933281000787;4291.313389857623;4297.419848320468;4309.091363329756;4317.7193482423545;4345.8478953236645;4149.33610622299;4370.650347972155;4372.103718737651;4376.387305777162;4395.582419670126;3709.8330575124182;3715.479832823407;3720.479132921393;3731.2724018816343;3745;5349.170878513836;5409.540189083933;5410.756515956791;5418.972905135449;5420.214068959979;4750;4850.781714822841;4879.365682461257;4904.6321525885705;4924.409070911478;5777.133429985493;5808.912866307009;5821.27234095738;5835.883282334329;5842.707864606795;4120.835166593332;4125.23683118624;4132.483439570054;4137.048478849852;4137.91724165515;5886.735096920649;6100.389961003909;6149.262088549358;6150.5079593632845;6151.569390142692;4140.296149654566;4156.709030367845;4184.497860256728;4193.853215137456;4202.432671589358;4245.936310955338;4250.936235956463;4268.914621707549;4269;4284.785760711952;4807.61539076873;4911.263310503382;4917.237828136645;4919.877003074952;4952.356193694796;5663.235463212496;5864.794732184353;5877.235959325346;5896.6756828374855;5916.970415147896;1447.6898406941734;1467.185711929889;1467.611083062989;1471.4261438039173;1477.8989652708585;898.9280857531381;905.3391024551983;931.9301052421096;942.8350038743192;946.6497395963538;5054.646174767731;5081.923771143436;5118.38579370478;5184.714840683799;5185.611079169077;5343.545798607084;5358.624896257303;5358.891842731285;5395.304216611634;5422.481705122572;4872.926906096412;5032.723200224023;5055.34280543527;5121.359830021247;5144.742762861842;2864.7851411144247;2869.397426540408;2869.569564565332;2883.048593963987;2906.7819913506573;5428.348598168245;5546.251256080458;5597.524210442077;5610.839826666681;5616.9157462638095;5197.766100525486;5400.432954539795;5418.997485465202;5455.8363249102595;5462.3445186577865;5406.270153529302;5498.697571633518;5514.448555144453;5531.6957567333375;5558;5186.196139598368;5187.41783755958;5281.498257665516;5324.459234608942;5359.169328754049;5239.685618862881;5338.519533242027;5353.197020446964;5364.624476286623;5385.6230063895155;5495.642783219078;5505.522514868406;5522.834314970557;5560.694161820977;5586.441355864381;3804.372278574004;3811.2187001665147;3866.7099967501986;3906.9609303907732;4222;5842.094475356326;5915.349311575637;6010.248718910137;6118.888983300754;6134.539909506716;5813.157092221689;5906.232189815297;5914.260717410324;5930.614510056833;5947.9702601486715;5857.326407463196;5866.735996880236;5869.501092407193;5874.823755287348;5889.175515427758;5606.887862242814;5681.715914204191;5745.971270143623;5762.761006383647;5784.94215057844;5850.2102216200265;5905.025670764448;5905.143754155709;5946.929552680559;5958.871592413844;5511.641743286674;5735.684537350486;5742.310922689304;5780.508656764222;5835.533157347317 14:36:00 INFO - PROCESS | 18508 | |5;yui.html;732.8497657980118;767.1254769562697;795.9164287749786;802.169754304295;813.9430239883211;14595.708085838276;15438.922805385986;15580;15662.530124096267;15924.363025478982;14435.783463248034;14561.563153105424;14571.417143314282;14590.781138282935;14600.342984565694;797.1709422200904;800.3277247112425;801.5391150088693;802.5906787538339;814.311906439061;811.4847072109224;812.2162113560413;816.481534225765;818.9754307370758;819.5041999590252;842.1452225990624;846.3990566697652;846.6401779243828;847.0978407995495;848.2832006954145;842.6629348260683;843.026304618164;843.0936743001298;843.1568431568431;844.2654890245526;612.4946918792015;612.5589575505629;612.7334609444906;613.6348872420903;616.300498933709;15052.473163439226;15094.924525377302;15138.318775655121;15199.240037998166;15213;13697.931510342483;13718.176909385369;13999.650008749863;14010.439582416691;14153.066547432703;11599;11729.70675733105;11741.88258117425;11868.465919033664;11906.940465297705;3681.2140428544353;3804.08701911542;3828.9808550957346;3876.2441323941844;3939.409088636699;73488.6325568374;74486.62756686182;75561.24438755542;75575;75761;10739.248252622398;10858.34849909008;10932.836007459895;10969.853232844172;11087.778244435067;19769.60460790776;19790.604187916448;19900.407967362575;19941.401757947286;20023.199072036954;8412.158784121539;8601;8624.655013799504;8741.431806932529;8895;4855.6601037927;4911.656184067152;4989.226669866177;4991.800327986913;5115.130427827278;3489.2149266414854;3601;3619.4570814378053;3622.800745958945;3629.8003609801185;630.4168644004369;641.5477088652489;647.8056583025074;648.1185587600859;666.8599594085297;657.7303305644758;686.5743239191634;691.4261163234604;692.3076923076923;705.9823504412328;9514.762130946781;9756.268279878896;9772;9840.212782977345;9873.80252394948;549.9532539734088;605.81825452365;614.8954677704801;662.8367215536798;694.8506071194718;4440.977795111004;4532.841350552715;4537.0925814837165;4567.5432456754725;4609.147307748078;110330;110731;112706.05528806453;113261.43369283265;117290;72706.63646681838;81631;97524.51237743908;98313;98340.50829745948;84404;85930.14069859346;86251.56874215588;87424;87934.56032719795;8004.879926801219;8616;8639.645634491086;8710.259627931444;8958.686445974621;46058.53941460676;51952.740236298574;53291.46708532865;53745.19382209192;53792.19311710249;70477.29522704707;70596.64701676459;71411;72399;75752.62123689346;10759.569617215224;10927.344359338465;11546.13403994687;11565.537378505102;11827.172097953406;12494.500219991098;12534.749305014031;12688.87311126877;12709.872901270868;12786.872131278567;11640.476178571815;11878.584249551224;11893.821592675944;12042.939785301018;12672.74654506923;11936.641900742992;12261;12296.508139674313;12642.178258413174;12651.683707907008;11546.94226528862;11760.70598235051;11846.644600661994;12039.63881083569;12171.57399491049;9940.706830433608;9952.800943980936;9978.850317245102;10280.640177593748;10570.947145264225;9532.299754470912;10297.639582614573;10398.584056637952;10403.843942341022;10423.791524169626 14:36:00 INFO - PROCESS | 18508 | __end_tp_report 14:36:00 INFO - PROCESS | 18508 | __start_cc_report 14:36:00 INFO - PROCESS | 18508 | _x_x_mozilla_cycle_collect,345 14:36:00 INFO - PROCESS | 18508 | __end_cc_report 14:36:00 INFO - PROCESS | 18508 | __startTimestamp1465076160623__endTimestamp 14:36:00 INFO - PROCESS | 18508 | 14:36:00 INFO - PROCESS | 18508 | ------- Summary: start ------- 14:36:00 INFO - PROCESS | 18508 | Number of tests: 6 14:36:00 INFO - PROCESS | 18508 | 14:36:00 INFO - PROCESS | 18508 | [#0] dojo.html Cycles:165 Average:5381.08 Median:5633.75 stddev:753.22 (13.4%) stddev-sans-first:733.74 14:36:00 INFO - PROCESS | 18508 | Values: 3088.3 3106.3 3149.3 3174.3 3176.8 5436.5 5473.6 5476.9 5489.1 5500.4 5318.8 5406.2 5486.2 5495.3 5573.8 4980.1 5002.8 5034.9 5128.4 5132.3 310.1 5005.6 5106.4 5121.1 5145.5 4850.6 4862.6 4873.3 4919.7 4934.5 4933.6 4944.5 4947.8 4957.5 4998.3 4870.6 4888.2 4917.4 4929.9 4951.1 5299.3 5365.9 5373.2 5390.3 5396.3 5784.8 5794.4 5794.6 5801.2 5850.2 5734.7 5744.9 5757.6 5780.5 5817.3 5427.1 5439.2 5440.9 5444.5 5461.7 5828.0 5949.5 5949.7 5950.2 5953.2 5699.0 5716.1 5726.0 5730.0 5731.9 5791.1 5865.4 5865.8 5869.9 5876.6 5702.8 5741.1 5830.5 5839.8 5859.0 5730.2 5773.7 5790.2 5794.5 5826.2 4311.3 4311.6 4312.9 4321.2 4331.0 3795.8 3810.3 3852.6 3872.4 3881.1 5344.8 5470.1 5493.3 5573.7 5606.4 5740.8 5827.7 5834.6 5834.6 5885.4 5537.1 5553.8 5567.9 5574.4 5578.2 4781.6 4829.4 4887.6 4948.0 4952.0 6096.1 6099.1 6129.1 6132.0 6147.6 5913.6 5958.7 5961.9 5966.6 5968.1 5744.2 5983.3 6084.2 6102.6 6166.4 5830.2 5850.1 5853.6 5854.0 5863.9 5757.7 5968.3 5973.2 5977.4 5987.8 5696.7 5716.7 5754.4 5757.5 5763.0 5752.4 5753.6 5762.9 5765.7 5769.3 5459.8 5508.4 5660.1 5663.3 5667.0 5633.7 5646.7 5648.6 5686.2 5747.1 5500.4 5531.6 5539.7 5548.2 5566.6 14:36:00 INFO - PROCESS | 18508 | 14:36:00 INFO - PROCESS | 18508 | [#1] ext.html Cycles:180 Average:59290.19 Median:42442.50 stddev:120620.37 (284.2%) stddev-sans-first:120878.22 14:36:00 INFO - PROCESS | 18508 | Values: 585.9 609.7 633.2 651.3 652.7 42688.6 43913.6 44133.3 44256.6 47308.1 43302.8 43639.3 43640.6 43905.3 44114.6 8475.0 8681.7 8693.7 8694.9 8698.8 8526.1 8706.0 8706.7 8708.7 8717.0 8736.8 8752.3 8815.3 8835.0 8843.6 8645.8 8654.0 8698.1 8728.3 8736.2 8542.8 8654.1 8708.9 8713.3 8742.7 39545.0 39546.8 39717.0 39899.0 40010.8 3405.2 3631.3 3739.4 4010.9 4237.3 31123.4 31360.0 31654.4 31665.4 32495.2 4353.1 4404.0 4498.9 4544.5 4572.0 293374.0 293817.0 294379.0 294927.0 295607.0 31045.5 56872.4 56987.7 57066.0 57186.0 35805.6 36939.1 37052.6 37160.0 37187.0 15022.2 15083.3 15143.5 15181.2 15202.4 12726.7 12740.5 12794.6 12799.6 12810.7 8289.3 8353.0 8359.3 8383.7 8521.7 3000.2 3022.6 3042.4 3046.4 3064.6 1041.9 1082.5 1133.1 1134.3 1158.4 31859.4 32752.3 32941.2 33099.7 33551.7 1116.1 1145.3 1178.5 1194.1 1239.8 17487.6 17515.6 17678.2 17741.6 17750.7 559246.0 565977.0 566317.0 567867.0 568336.0 60167.4 60651.4 60745.0 60901.0 60991.0 1346.9 1366.8 1385.7 1387.0 1392.6 32035.7 32636.7 32848.7 32935.3 33385.0 53480.0 53528.5 53529.0 53623.0 53636.0 455777.0 456199.0 456943.0 457949.0 459410.0 28920.6 29085.1 29578.9 29673.6 29755.7 49713.8 50291.5 50749.7 51546.0 51878.7 41855.8 42389.0 42607.4 43418.0 43527.1 42331.8 42353.8 42496.0 42655.0 42853.0 41818.4 42590.0 43173.1 43298.6 43386.6 36207.8 38424.6 38883.6 39421.0 39506.6 29077.9 29146.7 29201.9 29363.1 29400.1 14:36:00 INFO - PROCESS | 18508 | 14:36:00 INFO - PROCESS | 18508 | [#2] jquery.html Cycles:180 Average:28465.01 Median:2381.71 stddev:77668.33 (3261.0%) stddev-sans-first:77857.61 14:36:00 INFO - PROCESS | 18508 | Values: 393.2 396.1 397.8 402.7 410.6 14915.6 18256.2 18553.4 19712.5 19949.1 17642.3 17835.6 18092.1 18261.6 18264.1 5357.5 5555.4 5604.0 5606.6 5731.0 5559.9 5568.9 5587.4 5603.7 6507.7 6404.5 6417.9 6457.9 6462.0 6476.9 6235.6 6388.3 6390.5 6444.3 6455.1 5639.0 5644.1 5644.1 5660.8 5698.9 20609.0 21040.5 21836.2 21963.8 21985.2 2263.4 2377.7 2385.7 2654.9 2721.0 9863.1 9867.9 9874.5 9974.4 10283.5 1931.9 1988.3 2019.4 2020.4 2028.9 83556.0 89970.6 90023.5 90656.0 90727.0 10586.2 11079.7 11157.7 11185.3 11299.8 13950.8 13994.7 15567.9 15641.6 15644.6 7512.1 7775.0 7830.3 7890.5 8033.4 7354.6 7392.3 7433.3 7525.1 7533.4 4622.8 4643.8 4760.5 4767.6 4778.0 1975.2 1989.5 1998.4 2045.7 2102.1 1026.8 1027.0 1031.7 1082.3 1137.9 18719.3 19235.1 19330.4 19373.8 19459.3 1004.6 1006.5 1030.9 1033.3 1042.0 10557.4 10562.0 10719.1 10744.8 10892.3 466443.0 467001.0 469276.0 470639.0 471490.0 93002.5 94270.0 94513.0 94852.5 94958.0 1002.8 1034.0 1040.9 1049.7 1051.9 16615.4 16949.9 16970.2 17058.6 17343.0 39272.2 39559.8 40881.6 40905.2 41267.0 56150.4 56753.4 57050.7 57257.0 57444.4 8099.4 8334.2 8377.6 8458.8 8479.6 6853.0 8566.5 13119.1 13178.8 13273.3 11271.6 11451.9 11620.4 11705.6 11842.2 11446.7 11482.7 11507.0 11635.6 11668.1 11550.2 11651.2 11672.9 11842.7 12182.6 8345.4 8515.0 8581.3 8581.9 8602.1 11672.7 11866.0 11868.3 11979.3 12018.4 14:36:00 INFO - PROCESS | 18508 | 14:36:00 INFO - PROCESS | 18508 | [#3] mootools.html Cycles:180 Average:5939.97 Median:455.87 stddev:3475.37 (762.4%) stddev-sans-first:3469.05 14:36:00 INFO - PROCESS | 18508 | Values: 1492.5 1552.4 1678.6 1798.1 1818.6 7876.4 8622.7 8656.9 9240.5 9258.9 8907.2 9162.1 9233.3 9238.3 9254.7 2333.8 2357.1 2373.8 2378.9 2380.4 2298.1 2334.1 2335.1 2348.4 2349.4 2247.8 2251.2 2257.6 2276.5 2277.6 2275.8 2301.7 2304.5 2309.9 2311.2 2245.8 2288.2 2320.7 2321.4 2332.6 9054.0 9066.8 9165.0 9169.9 9175.6 5064.1 5175.5 5180.2 5215.3 5223.3 3266.3 3356.5 3422.8 3466.9 3479.9 1120.4 1139.8 2196.3 2217.4 2267.1 12943.7 13023.4 13073.2 13082.3 13144.3 4421.4 4428.8 4477.5 4482.1 4562.2 10271.2 10325.2 10331.2 10343.7 10347.7 5109.1 5230.8 5237.3 5270.9 5278.5 4221.6 4854.7 4860.1 4969.3 4988.7 3911.7 3917.4 3978.1 4025.1 4026.9 1117.5 1120.5 1122.7 1138.8 1146.4 865.5 940.2 955.0 972.8 982.7 5937.3 5945.6 5959.9 5974.9 5988.7 450.2 455.1 456.7 458.1 467.2 3952.4 3991.8 4034.3 4043.9 4055.1 11320.0 11689.4 11705.8 11734.0 11754.9 11578.7 11582.7 11613.3 11616.8 11617.0 8128.5 8559.9 8612.1 8674.5 8694.3 5716.3 5922.4 6101.8 6105.5 6110.1 9929.0 10321.9 10333.4 10429.9 10450.1 10063.6 10379.7 10505.8 10673.3 10689.7 7509.8 7910.0 8064.9 8339.3 8461.6 8909.0 8910.6 8940.3 8940.9 8951.6 7776.8 7971.5 8139.5 8218.6 8218.9 7852.9 7932.0 8023.5 8109.8 8119.4 6857.2 6909.8 6977.2 6990.5 7113.1 5100.0 5108.8 5111.5 5128.2 5278.0 5108.6 5127.8 5222.4 5234.1 5313.6 14:36:00 INFO - PROCESS | 18508 | 14:36:00 INFO - PROCESS | 18508 | [#4] prototype.html Cycles:180 Average:4742.99 Median:5358.76 stddev:1388.72 (25.9%) stddev-sans-first:1352.14 14:36:00 INFO - PROCESS | 18508 | Values: 308.5 311.3 317.2 321.7 332.0 5530.7 5574.9 5713.6 5755.9 5783.2 5570.0 5635.7 5635.8 5639.4 5642.7 4412.7 4421.9 4436.0 4441.1 4442.5 4350.0 4356.9 4379.0 4434.9 4447.9 4291.3 4297.4 4309.1 4317.7 4345.8 4149.3 4370.7 4372.1 4376.4 4395.6 3709.8 3715.5 3720.5 3731.3 3745.0 5349.2 5409.5 5410.8 5419.0 5420.2 4750.0 4850.8 4879.4 4904.6 4924.4 5777.1 5808.9 5821.3 5835.9 5842.7 4120.8 4125.2 4132.5 4137.0 4137.9 5886.7 6100.4 6149.3 6150.5 6151.6 4140.3 4156.7 4184.5 4193.9 4202.4 4245.9 4250.9 4268.9 4269.0 4284.8 4807.6 4911.3 4917.2 4919.9 4952.4 5663.2 5864.8 5877.2 5896.7 5917.0 1447.7 1467.2 1467.6 1471.4 1477.9 898.9 905.3 931.9 942.8 946.6 5054.6 5081.9 5118.4 5184.7 5185.6 5343.5 5358.6 5358.9 5395.3 5422.5 4872.9 5032.7 5055.3 5121.4 5144.7 2864.8 2869.4 2869.6 2883.0 2906.8 5428.3 5546.3 5597.5 5610.8 5616.9 5197.8 5400.4 5419.0 5455.8 5462.3 5406.3 5498.7 5514.4 5531.7 5558.0 5186.2 5187.4 5281.5 5324.5 5359.2 5239.7 5338.5 5353.2 5364.6 5385.6 5495.6 5505.5 5522.8 5560.7 5586.4 3804.4 3811.2 3866.7 3907.0 4222.0 5842.1 5915.3 6010.2 6118.9 6134.5 5813.2 5906.2 5914.3 5930.6 5948.0 5857.3 5866.7 5869.5 5874.8 5889.2 5606.9 5681.7 5746.0 5762.8 5784.9 5850.2 5905.0 5905.1 5946.9 5958.9 5511.6 5735.7 5742.3 5780.5 5835.5 14:36:00 INFO - PROCESS | 18508 | 14:36:00 INFO - PROCESS | 18508 | [#5] yui.html Cycles:180 Average:20016.95 Median:5053.47 stddev:29064.97 (575.1%) stddev-sans-first:29110.44 14:36:00 INFO - PROCESS | 18508 | Values: 732.8 767.1 795.9 802.2 813.9 14595.7 15438.9 15580.0 15662.5 15924.4 14435.8 14561.6 14571.4 14590.8 14600.3 797.2 800.3 801.5 802.6 814.3 811.5 812.2 816.5 819.0 819.5 842.1 846.4 846.6 847.1 848.3 842.7 843.0 843.1 843.2 844.3 612.5 612.6 612.7 613.6 616.3 15052.5 15094.9 15138.3 15199.2 15213.0 13697.9 13718.2 13999.7 14010.4 14153.1 11599.0 11729.7 11741.9 11868.5 11906.9 3681.2 3804.1 3829.0 3876.2 3939.4 73488.6 74486.6 75561.2 75575.0 75761.0 10739.2 10858.3 10932.8 10969.9 11087.8 19769.6 19790.6 19900.4 19941.4 20023.2 8412.2 8601.0 8624.7 8741.4 8895.0 4855.7 4911.7 4989.2 4991.8 5115.1 3489.2 3601.0 3619.5 3622.8 3629.8 630.4 641.5 647.8 648.1 666.9 657.7 686.6 691.4 692.3 706.0 9514.8 9756.3 9772.0 9840.2 9873.8 550.0 605.8 614.9 662.8 694.9 4441.0 4532.8 4537.1 4567.5 4609.1 110330.0 110731.0 112706.1 113261.4 117290.0 72706.6 81631.0 97524.5 98313.0 98340.5 84404.0 85930.1 86251.6 87424.0 87934.6 8004.9 8616.0 8639.6 8710.3 8958.7 46058.5 51952.7 53291.5 53745.2 53792.2 70477.3 70596.6 71411.0 72399.0 75752.6 10759.6 10927.3 11546.1 11565.5 11827.2 12494.5 12534.7 12688.9 12709.9 12786.9 11640.5 11878.6 11893.8 12042.9 12672.7 11936.6 12261.0 12296.5 12642.2 12651.7 11546.9 11760.7 11846.6 12039.6 12171.6 9940.7 9952.8 9978.9 10280.6 10570.9 9532.3 10297.6 10398.6 10403.8 10423.8 14:36:00 INFO - PROCESS | 18508 | -------- Summary: end -------- 14:36:00 INFO - PROCESS | 18508 | 14:36:01 INFO - TEST-INFO | 18508: exit 0 14:36:01 INFO - TEST-OK | dromaeo_css | took 1109178ms 14:36:01 INFO - TEST-START | kraken 14:36:01 INFO - operating with platform_type : linux_ 14:36:01 INFO - Initialising browser for kraken test... 14:36:01 INFO - TEST-INFO | started process 18742 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKzbmQ5/profile http://localhost:55346/getInfo.html) 14:36:05 INFO - PROCESS | 18742 | __metrics Screen width/height:1600/1200 14:36:05 INFO - PROCESS | 18742 | colorDepth:24 14:36:05 INFO - PROCESS | 18742 | Browser inner width/height: 1024/697 14:36:05 INFO - PROCESS | 18742 | __metrics 14:36:06 ERROR - PROCESS | 18742 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2938: TypeError: this.tabs is undefined 14:36:07 INFO - TEST-INFO | 18742: exit 0 14:36:07 INFO - Browser initialized. 14:36:07 INFO - Running cycle 1/1 for kraken test... 14:36:07 INFO - TEST-INFO | started process 18861 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKzbmQ5/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:36:18 INFO - PROCESS | 18861 | RSS: Main: 167538688 14:36:18 INFO - PROCESS | 18861 | 14:36:21 INFO - PROCESS | 18861 | Cycle 1(1): loaded http://localhost:55346/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55346/tests/kraken/driver.html?testName=audio-beat-detection) 14:36:22 INFO - PROCESS | 18861 | RSS: Main: 173129728 14:36:22 INFO - PROCESS | 18861 | 14:36:24 INFO - PROCESS | 18861 | Cycle 1(1): loaded http://localhost:55346/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55346/tests/kraken/driver.html?testName=audio-dft) 14:36:25 INFO - PROCESS | 18861 | RSS: Main: 172105728 14:36:25 INFO - PROCESS | 18861 | 14:36:28 INFO - PROCESS | 18861 | Cycle 1(1): loaded http://localhost:55346/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55346/tests/kraken/driver.html?testName=audio-fft) 14:36:29 INFO - PROCESS | 18861 | RSS: Main: 167059456 14:36:29 INFO - PROCESS | 18861 | 14:36:31 INFO - PROCESS | 18861 | Cycle 1(1): loaded http://localhost:55346/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55346/tests/kraken/driver.html?testName=audio-oscillator) 14:36:31 INFO - PROCESS | 18861 | RSS: Main: 167874560 14:36:31 INFO - PROCESS | 18861 | 14:36:33 INFO - PROCESS | 18861 | Cycle 1(1): loaded http://localhost:55346/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55346/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:36:34 INFO - PROCESS | 18861 | RSS: Main: 168198144 14:36:34 INFO - PROCESS | 18861 | 14:36:37 INFO - PROCESS | 18861 | Cycle 1(1): loaded http://localhost:55346/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55346/tests/kraken/driver.html?testName=imaging-darkroom) 14:36:38 INFO - PROCESS | 18861 | RSS: Main: 167751680 14:36:38 INFO - PROCESS | 18861 | 14:36:41 INFO - PROCESS | 18861 | Cycle 1(1): loaded http://localhost:55346/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55346/tests/kraken/driver.html?testName=imaging-desaturate) 14:36:42 INFO - PROCESS | 18861 | RSS: Main: 168931328 14:36:42 INFO - PROCESS | 18861 | 14:36:45 INFO - PROCESS | 18861 | Cycle 1(1): loaded http://localhost:55346/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55346/tests/kraken/driver.html?testName=json-parse-financial) 14:36:45 INFO - PROCESS | 18861 | RSS: Main: 168722432 14:36:45 INFO - PROCESS | 18861 | 14:36:47 INFO - PROCESS | 18861 | Cycle 1(1): loaded http://localhost:55346/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55346/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:36:48 INFO - PROCESS | 18861 | RSS: Main: 168583168 14:36:48 INFO - PROCESS | 18861 | 14:36:49 INFO - PROCESS | 18861 | Cycle 1(1): loaded http://localhost:55346/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55346/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:36:50 INFO - PROCESS | 18861 | RSS: Main: 168431616 14:36:50 INFO - PROCESS | 18861 | 14:36:52 INFO - PROCESS | 18861 | Cycle 1(1): loaded http://localhost:55346/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55346/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:36:53 INFO - PROCESS | 18861 | RSS: Main: 169627648 14:36:53 INFO - PROCESS | 18861 | 14:36:55 INFO - PROCESS | 18861 | Cycle 1(1): loaded http://localhost:55346/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55346/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:36:56 INFO - PROCESS | 18861 | RSS: Main: 169582592 14:36:56 INFO - PROCESS | 18861 | 14:36:59 INFO - PROCESS | 18861 | Cycle 1(1): loaded http://localhost:55346/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55346/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:36:59 INFO - PROCESS | 18861 | RSS: Main: 169562112 14:36:59 INFO - PROCESS | 18861 | 14:37:01 INFO - PROCESS | 18861 | Cycle 1(1): loaded http://localhost:55346/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55346/tests/kraken/driver.html?testName=ai-astar) 14:37:01 INFO - PROCESS | 18861 | RSS: Main: 170647552 14:37:01 INFO - PROCESS | 18861 | 14:37:01 INFO - PROCESS | 18861 | __start_tp_report 14:37:01 INFO - PROCESS | 18861 | _x_x_mozilla_page_load 14:37:01 INFO - PROCESS | 18861 | _x_x_mozilla_page_load_details 14:37:01 INFO - PROCESS | 18861 | |i|pagename|runs| 14:37:01 INFO - PROCESS | 18861 | |0;ai-astar;111;105;112;110;111;112;111;109;111;113 14:37:01 INFO - PROCESS | 18861 | |1;audio-beat-detection;156;125;175;174;127;160;154;130;186;125 14:37:01 INFO - PROCESS | 18861 | |2;audio-dft;163;163;163;163;162;166;174;164;163;163 14:37:01 INFO - PROCESS | 18861 | |3;audio-fft;74;74;75;167;76;76;75;75;172;76 14:37:01 INFO - PROCESS | 18861 | |4;audio-oscillator;87;84;154;85;86;85;136;85;84;157 14:37:01 INFO - PROCESS | 18861 | |5;imaging-gaussian-blur;120;118;117;117;117;117;118;118;117;123 14:37:01 INFO - PROCESS | 18861 | |6;imaging-darkroom;148;146;146;147;148;147;147;147;148;146 14:37:01 INFO - PROCESS | 18861 | |7;imaging-desaturate;95;96;95;99;96;95;95;96;95;95 14:37:01 INFO - PROCESS | 18861 | |8;json-parse-financial;54;53;56;53;53;53;55;54;54;55 14:37:01 INFO - PROCESS | 18861 | |9;json-stringify-tinderbox;62;63;64;62;65;64;62;63;61;62 14:37:01 INFO - PROCESS | 18861 | |10;stanford-crypto-aes;81;87;80;81;82;84;81;82;105;91 14:37:01 INFO - PROCESS | 18861 | |11;stanford-crypto-ccm;130;121;130;122;126;132;123;128;125;132 14:37:01 INFO - PROCESS | 18861 | |12;stanford-crypto-pbkdf2;162;159;161;166;161;167;160;158;163;173 14:37:01 INFO - PROCESS | 18861 | |13;stanford-crypto-sha256-iterative;68;64;63;63;64;65;61;63;63;62 14:37:01 INFO - PROCESS | 18861 | __end_tp_report 14:37:01 INFO - PROCESS | 18861 | __start_cc_report 14:37:01 INFO - PROCESS | 18861 | _x_x_mozilla_cycle_collect,859 14:37:01 INFO - PROCESS | 18861 | __end_cc_report 14:37:01 INFO - PROCESS | 18861 | __startTimestamp1465076221747__endTimestamp 14:37:01 INFO - PROCESS | 18861 | 14:37:01 INFO - PROCESS | 18861 | ------- Summary: start ------- 14:37:01 INFO - PROCESS | 18861 | Number of tests: 14 14:37:01 INFO - PROCESS | 18861 | 14:37:01 INFO - PROCESS | 18861 | [#0] ai-astar Cycles:10 Average:110.50 Median:111.00 stddev:2.22 (2.0%) stddev-sans-first:2.35 14:37:01 INFO - PROCESS | 18861 | Values: 111.0 105.0 112.0 110.0 111.0 112.0 111.0 109.0 111.0 113.0 14:37:01 INFO - PROCESS | 18861 | 14:37:01 INFO - PROCESS | 18861 | [#1] audio-beat-detection Cycles:10 Average:151.20 Median:158.00 stddev:23.13 (14.6%) stddev-sans-first:24.46 14:37:01 INFO - PROCESS | 18861 | Values: 156.0 125.0 175.0 174.0 127.0 160.0 154.0 130.0 186.0 125.0 14:37:01 INFO - PROCESS | 18861 | 14:37:01 INFO - PROCESS | 18861 | [#2] audio-dft Cycles:10 Average:164.40 Median:163.00 stddev:3.53 (2.2%) stddev-sans-first:3.71 14:37:01 INFO - PROCESS | 18861 | Values: 163.0 163.0 163.0 163.0 162.0 166.0 174.0 164.0 163.0 163.0 14:37:01 INFO - PROCESS | 18861 | 14:37:01 INFO - PROCESS | 18861 | [#3] audio-fft Cycles:10 Average:94.00 Median:75.00 stddev:39.82 (53.1%) stddev-sans-first:41.57 14:37:01 INFO - PROCESS | 18861 | Values: 74.0 74.0 75.0 167.0 76.0 76.0 75.0 75.0 172.0 76.0 14:37:01 INFO - PROCESS | 18861 | 14:37:01 INFO - PROCESS | 18861 | [#4] audio-oscillator Cycles:10 Average:104.30 Median:85.00 stddev:31.32 (36.8%) stddev-sans-first:32.59 14:37:01 INFO - PROCESS | 18861 | Values: 87.0 84.0 154.0 85.0 86.0 85.0 136.0 85.0 84.0 157.0 14:37:01 INFO - PROCESS | 18861 | 14:37:01 INFO - PROCESS | 18861 | [#5] imaging-gaussian-blur Cycles:10 Average:118.20 Median:118.00 stddev:1.93 (1.6%) stddev-sans-first:1.94 14:37:01 INFO - PROCESS | 18861 | Values: 120.0 118.0 117.0 117.0 117.0 117.0 118.0 118.0 117.0 123.0 14:37:01 INFO - PROCESS | 18861 | 14:37:01 INFO - PROCESS | 18861 | [#6] imaging-darkroom Cycles:10 Average:147.00 Median:147.00 stddev:0.82 (0.6%) stddev-sans-first:0.78 14:37:01 INFO - PROCESS | 18861 | Values: 148.0 146.0 146.0 147.0 148.0 147.0 147.0 147.0 148.0 146.0 14:37:01 INFO - PROCESS | 18861 | 14:37:01 INFO - PROCESS | 18861 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:95.50 stddev:1.25 (1.3%) stddev-sans-first:1.30 14:37:01 INFO - PROCESS | 18861 | Values: 95.0 96.0 95.0 99.0 96.0 95.0 95.0 96.0 95.0 95.0 14:37:01 INFO - PROCESS | 18861 | 14:37:01 INFO - PROCESS | 18861 | [#8] json-parse-financial Cycles:10 Average:54.00 Median:54.00 stddev:1.05 (2.0%) stddev-sans-first:1.12 14:37:01 INFO - PROCESS | 18861 | Values: 54.0 53.0 56.0 53.0 53.0 53.0 55.0 54.0 54.0 55.0 14:37:01 INFO - PROCESS | 18861 | 14:37:01 INFO - PROCESS | 18861 | [#9] json-stringify-tinderbox Cycles:10 Average:62.80 Median:63.00 stddev:1.23 (2.0%) stddev-sans-first:1.27 14:37:01 INFO - PROCESS | 18861 | Values: 62.0 63.0 64.0 62.0 65.0 64.0 62.0 63.0 61.0 62.0 14:37:01 INFO - PROCESS | 18861 | 14:37:01 INFO - PROCESS | 18861 | [#10] stanford-crypto-aes Cycles:10 Average:85.40 Median:82.00 stddev:7.68 (9.4%) stddev-sans-first:7.98 14:37:01 INFO - PROCESS | 18861 | Values: 81.0 87.0 80.0 81.0 82.0 84.0 81.0 82.0 105.0 91.0 14:37:01 INFO - PROCESS | 18861 | 14:37:01 INFO - PROCESS | 18861 | [#11] stanford-crypto-ccm Cycles:10 Average:126.90 Median:129.00 stddev:4.09 (3.2%) stddev-sans-first:4.19 14:37:01 INFO - PROCESS | 18861 | Values: 130.0 121.0 130.0 122.0 126.0 132.0 123.0 128.0 125.0 132.0 14:37:01 INFO - PROCESS | 18861 | 14:37:01 INFO - PROCESS | 18861 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:163.00 Median:162.50 stddev:4.52 (2.8%) stddev-sans-first:4.78 14:37:01 INFO - PROCESS | 18861 | Values: 162.0 159.0 161.0 166.0 161.0 167.0 160.0 158.0 163.0 173.0 14:37:01 INFO - PROCESS | 18861 | 14:37:01 INFO - PROCESS | 18861 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.60 Median:63.50 stddev:1.90 (3.0%) stddev-sans-first:1.17 14:37:01 INFO - PROCESS | 18861 | Values: 68.0 64.0 63.0 63.0 64.0 65.0 61.0 63.0 63.0 62.0 14:37:01 INFO - PROCESS | 18861 | -------- Summary: end -------- 14:37:01 INFO - PROCESS | 18861 | 14:37:02 INFO - TEST-INFO | 18861: exit 0 14:37:02 INFO - TEST-OK | kraken | took 61315ms 14:37:02 INFO - SUITE-END | took 1170s 14:37:02 INFO - Completed test suite (00:19:30) 14:37:02 INFO - javascript benchmark 14:37:02 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7175.969238300721, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3088.274255549946, 3106.347666989932, 3149.2599239178794, 3174.3175217328285, 3176.761742869285, 5436.510714035736, 5473.589480788942, 5476.945230547693, 5489.066858634032, 5500.4499550044975, 5318.76065577049, 5406.189071639246, 5486.204500347447, 5495.258140151079, 5573.804916827912, 4980.128477516439, 5002.849914502553, 5034.924476132843, 5128.4358720540895, 5132.28148059272, 310.11229654137895, 5005.574526165262, 5106.4382917879, 5121.052605268019, 5145.536901678848, 4850.563449289563, 4862.586680132175, 4873.269009648563, 4919.72941488218, 4934.4572097069295, 4933.605311575066, 4944.505549445063, 4947.752612369367, 4957.454679985199, 4998.275250088716, 4870.561649451531, 4888.242322440027, 4917.360743103373, 4929.876753081202, 4951.084049450863, 5299.311089558371, 5365.946340536584, 5373.167159090347, 5390.272313237702, 5396.298481197458, 5784.768609255625, 5794.391588883149, 5794.62334948227, 5801.158831969383, 5850.180974663551, 5734.741936612862, 5744.913826292609, 5757.596968212227, 5780.450857168605, 5817.331006934172, 5427.131658934591, 5439.156930675712, 5440.863978400532, 5444.50999410055, 5461.69960652164, 5828.0, 5949.494292985059, 5949.702514874239, 5950.196723442323, 5953.196318497034, 5698.971505142447, 5716.114002329562, 5726.0, 5730.0, 5731.856703582361, 5791.0734282514595, 5865.35481097079, 5865.794697185664, 5869.911951320733, 5876.588638795243, 5702.8289151325525, 5741.1388291756575, 5830.47525722687, 5839.766409343663, 5858.970705146532, 5730.19777231188, 5773.711314434261, 5790.247267855152, 5794.536437085023, 5826.213461182686, 4311.288637374861, 4311.611954924072, 4312.892177695583, 4321.178975994551, 4331.025519258142, 3795.8481660733814, 3810.3141434541494, 3852.5569559500454, 3872.4191371294532, 3881.107345310594, 5344.812931547377, 5470.070088085035, 5493.258410114583, 5573.721313934287, 5606.355269144019, 5740.799072032459, 5827.65034097947, 5834.562407819346, 5834.591578589458, 5885.440883116097, 5537.141743029837, 5553.805616803393, 5567.916481252784, 5574.386817450078, 5578.219049333096, 4781.641376896677, 4829.444613869379, 4887.633427492952, 4948.0, 4951.950480495149, 6096.055111457731, 6099.054646529795, 6129.08063790435, 6132.049532322497, 6147.569670123138, 5913.645181289136, 5958.702064896651, 5961.91057134152, 5966.582339236212, 5968.104784282305, 5744.167095771007, 5983.341832398346, 6084.178635884276, 6102.603330783485, 6166.445019948226, 5830.2129212555765, 5850.063989761617, 5853.619514731528, 5854.0, 5863.912041319469, 5757.65454072757, 5968.283805943314, 5973.193618861572, 5977.432143946318, 5987.790427335022, 5696.746715722535, 5716.742746576498, 5754.395788442321, 5757.510611598061, 5763.0, 5752.395998420106, 5753.626014309057, 5762.884742305214, 5765.682887441231, 5769.278840144982, 5459.754311056092, 5508.44915508446, 5660.122680984454, 5663.32040155184, 5667.036603777286, 5633.746481408264, 5646.7458964347525, 5648.57635677334, 5686.232358631697, 5747.08046712524, 5500.4499550044675, 5531.640443371168, 5539.667619942817, 5548.195511650869, 5566.610337276352], "value": 5331.215797141993, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [585.947264746173, 609.7439075588253, 633.170546583975, 651.2770824384935, 652.7454292825798, 42688.573114268846, 43913.560864391344, 44133.33799993002, 44256.557434425646, 47308.05383892329, 43302.783486082524, 43639.3454098188, 43640.563594364045, 43905.34141987873, 44114.55885441144, 8474.957625211866, 8681.696140635078, 8693.739187824376, 8694.913050869474, 8698.826023479527, 8526.147385261485, 8705.956470217672, 8706.651733930636, 8708.738737837875, 8717.0, 8736.781580460507, 8752.299816014736, 8815.294776417872, 8834.955825220864, 8843.557822108869, 8645.783855403603, 8653.956730216309, 8698.130186981283, 8728.345374096969, 8736.213740763298, 8542.829143417097, 8654.09132041133, 8708.869366959501, 8713.259372953307, 8742.650293988296, 39545.0, 39546.80226598849, 39717.02829717034, 39899.0, 40010.79994600038, 3405.1827561385335, 3631.2555926035097, 3739.3891965447165, 4010.8830076675736, 4237.279662457389, 31123.377532449224, 31360.0, 31654.36691266162, 31665.36669266602, 32495.187620309443, 4353.107612939371, 4404.005276412038, 4498.8875278117985, 4544.454665440168, 4571.9542804571865, 293374.0, 293817.0, 294379.0, 294927.0, 295607.0, 31045.534316985264, 56872.431275686715, 56987.71506142443, 57066.0, 57186.0, 35805.641943580755, 36939.07652308714, 37052.62947370492, 37160.0, 37187.0, 15022.248887555797, 15083.321250543751, 15143.545693629208, 15181.240937953058, 15202.391904323704, 12726.745465090831, 12740.490380384867, 12794.616161515169, 12799.616011519669, 12810.679733006564, 8289.295409890106, 8353.039400468902, 8359.331253499706, 8383.748487545383, 8521.659133634708, 3000.219942814884, 3022.637283525991, 3042.406730687539, 3046.436409264293, 3064.5556394323144, 1041.9270651054353, 1082.5223569827128, 1133.144475920691, 1134.3307448605362, 1158.4381574936149, 31859.362812743617, 32752.34495310128, 32941.18823464685, 33099.66900331014, 33551.664483355344, 1116.1223174902052, 1145.3471521232984, 1178.452019810792, 1194.134252666827, 1239.8264243005985, 17487.562810929827, 17515.649687006444, 17678.204480798395, 17741.645167096587, 17750.733738993924, 559246.0, 565977.0, 566317.0, 567867.0, 568336.0, 60167.39832601706, 60651.393486065455, 60745.0, 60901.0, 60991.0, 1346.9259190744604, 1366.8496465388798, 1385.7159282347295, 1386.9930650346685, 1392.5891861900764, 32035.679643204203, 32636.673633263363, 32848.67151328552, 32935.34129317352, 33385.0, 53480.0, 53528.46471535235, 53529.0, 53623.0, 53636.0, 455777.0, 456199.0, 456943.0, 457949.0, 459410.0, 28920.566191506725, 29085.127446176648, 29578.852105740196, 29673.554896677, 29755.702442975293, 49713.751431242614, 50291.497085028685, 50749.74625126851, 51546.0, 51878.74060629673, 41855.7907210462, 42389.0, 42607.36088958606, 43418.0, 43527.129457411305, 42331.7883410581, 42353.78823105865, 42496.0, 42655.0, 42853.0, 41818.37272440855, 42590.0, 43173.13653726845, 43298.567014329456, 43386.56613433825, 36207.818960905024, 38424.6157538421, 38883.61116388913, 39421.0, 39506.60493395029, 29077.854610726812, 29146.7085329144, 29201.85399072991, 29363.119106426842, 29400.11799646014], "value": 19116.55537068778, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [393.2037623811782, 396.0850435494007, 397.7871838566366, 402.71407300816423, 410.5689026522151, 14915.552533423988, 18256.17847196876, 18553.443396698105, 19712.507187320305, 19949.102290396913, 17642.294308227654, 17835.554111147227, 18092.09539523025, 18261.634767304648, 18264.086795660198, 5357.517823395893, 5555.444455554442, 5604.047311956957, 5606.579506537026, 5731.0, 5559.916601250984, 5568.86077848053, 5587.413321601234, 5603.663780173182, 6507.739690412378, 6404.487640988733, 6417.93582064178, 6457.8708425831455, 6461.967690161543, 6476.935230647704, 6235.594686345373, 6388.297287298394, 6390.520710946697, 6444.323346048691, 6455.128557644728, 5639.041362968305, 5644.068728659766, 5644.096944488862, 5660.830175094754, 5698.886022279573, 20609.0, 21040.473988150417, 21836.23573174931, 21963.780362196332, 21985.23051693199, 2263.3549438409973, 2377.7265614454386, 2385.7017872765905, 2654.9203523894316, 2720.9727902720915, 9863.112319891245, 9867.851982220272, 9874.456904870229, 9974.351667141686, 10283.53724082418, 1931.9227230910747, 1988.3239698502578, 2019.3840878532042, 2020.3938818354582, 2028.9334888682733, 83556.0, 89970.55014724884, 90023.54988225017, 90656.0, 90727.0, 10586.153107751361, 11079.667609971713, 11157.72105697364, 11185.272957257752, 11299.830502542469, 13950.790738138936, 13994.720105598035, 15567.922160389126, 15641.608959776097, 15644.608884777745, 7512.0985481741445, 7775.0, 7830.295273425305, 7890.526568405914, 8033.437659363905, 7354.595497247703, 7392.334689877936, 7433.331000209899, 7525.134609519975, 7533.397328213729, 4622.815087396467, 4643.8374656886845, 4760.500147484534, 4767.594754445841, 4777.95222047782, 1975.2395327798902, 1989.5424052468013, 1998.4004798560375, 2045.7340545729257, 2102.138123369442, 1026.7638443158116, 1027.0, 1031.7111208861531, 1082.2965072702648, 1137.886211378872, 18719.25122995092, 19235.13441895118, 19330.4200873974, 19373.806261937483, 19459.318923837596, 1004.6182450668699, 1006.5420233793752, 1030.8814486334018, 1033.2715435617872, 1042.003914986022, 10557.419341936115, 10562.049415552483, 10719.14246860265, 10744.785104297871, 10892.346459212473, 466443.0, 467001.0, 469276.0, 470639.0, 471490.0, 93002.53498732463, 94270.0, 94513.0, 94852.52573737087, 94958.0, 1002.819492491344, 1033.963811266602, 1040.9323393979366, 1049.6693541534391, 1051.9053285204368, 16615.41846035383, 16949.91525042367, 16970.151492425575, 17058.573535661708, 17343.0, 39272.214555709295, 39559.80220098881, 40881.59118408778, 40905.18189636131, 41266.9683257921, 56150.43849561452, 56753.432465676466, 57050.714746426005, 57257.0, 57444.42555574391, 8099.392545558989, 8334.20825021622, 8377.58112094405, 8458.788530286793, 8479.576021199038, 6853.040574319699, 8566.48601083937, 13119.08166428379, 13178.80231796543, 13273.336333183495, 11271.605493807678, 11451.885481145082, 11620.418979051183, 11705.590304339306, 11842.230255033395, 11446.713832154262, 11482.655520334403, 11507.0, 11635.5927542539, 11668.124890633406, 11550.191486595857, 11651.242669226473, 11672.88327116718, 11842.703932401759, 12182.573609923611, 8345.41582089248, 8515.0, 8581.313494920267, 8581.871271931052, 8602.139786021598, 11672.70818229551, 11866.0, 11868.347240901834, 11979.34113623759, 12018.399080046138], "value": 9202.789834858318, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1492.5298530962746, 1552.441121196369, 1678.5887457572896, 1798.1189217283536, 1818.618090201057, 7876.448648594601, 8622.698205562807, 8656.913430865698, 9240.537973101344, 9258.861117083241, 8907.242884354837, 9162.083791620835, 9233.261339092873, 9238.260939124872, 9254.67608633698, 2333.8482998605077, 2357.068957761683, 2373.8100951923893, 2378.8691621960784, 2380.4048987753063, 2298.10373954158, 2334.1013709721797, 2335.1359996801207, 2348.43637526994, 2349.3539276698875, 2247.797698207161, 2251.2120757734824, 2257.638777795553, 2276.4877902471894, 2277.635578307471, 2275.82931280153, 2301.6777651128855, 2304.5045315257216, 2309.872956987365, 2311.179531266393, 2245.8091062259728, 2288.164819840746, 2320.7215134184007, 2321.3848330192513, 2332.5568142052957, 9053.958794738623, 9066.77333066672, 9164.95417522908, 9169.862452063224, 9175.632974681004, 5064.063148317537, 5175.534201921845, 5180.222966555009, 5215.295935048795, 5223.294855194538, 3266.265090354675, 3356.5153020474045, 3422.828858557087, 3466.9306613867834, 3479.878204262864, 1120.4005856866618, 1139.8233273842484, 2196.3191410662744, 2217.390217690132, 2267.115824828318, 12943.741125177443, 13023.413946372437, 13073.15024523403, 13082.345882705922, 13144.277064761434, 4421.3861940391525, 4428.800703968329, 4477.485089214782, 4482.103579284156, 4562.24722920721, 10271.229657775697, 10325.225608079425, 10331.22515811302, 10343.741406464898, 10347.741306467247, 5109.105906466353, 5230.843074707765, 5237.3453318335205, 5270.92093618596, 5278.524932755993, 4221.598948099926, 4854.708717476963, 4860.125177468019, 4969.2546118081855, 4988.72562009093, 3911.726179167431, 3917.4319723639915, 3978.0850404407147, 4025.1144748155357, 4026.939595906064, 1117.5082963496036, 1120.4733775125678, 1122.6575894352302, 1138.7893239750672, 1146.415328182633, 865.4936861935838, 940.1773448232797, 954.9972528844685, 972.781124247053, 982.7002764157, 5937.34689184198, 5945.583809133319, 5959.910601340984, 5974.850628734316, 5988.700564971821, 450.2435907675137, 455.0534887434129, 456.68032377336, 458.06783196195585, 467.1870944556515, 3952.3676211805973, 3991.820368083443, 4034.3141665916864, 4043.939340909889, 4055.148418832019, 11320.0, 11689.357085360387, 11705.824412633818, 11734.0, 11754.88245117555, 11578.71053223676, 11582.710432239093, 11613.30320180792, 11616.825747613793, 11617.0, 8128.512289262663, 8559.914400856036, 8612.052674205832, 8674.522901240493, 8694.347923905732, 5716.3140423147825, 5922.407759224216, 6101.816945491642, 6105.511559075175, 6110.052941794029, 9928.950355248466, 10321.948390258001, 10333.431661258403, 10429.9478502607, 10450.111740501838, 10063.647772327933, 10379.740506487398, 10505.789884202426, 10673.252872299176, 10689.679309620724, 7509.774706758588, 7909.960450197942, 8064.919350806417, 8339.291160251447, 8461.61922713467, 8908.955455222682, 8910.55447227623, 8940.284777217938, 8940.910590894007, 8951.552422378725, 7776.766696999099, 7971.511841882866, 8139.511629302024, 8218.630161642861, 8218.917810821815, 7852.882206767017, 7932.0, 8023.4784738991775, 8109.837803243784, 8119.350451963711, 6857.245702972768, 6909.792706218822, 6977.197622273504, 6990.510664253657, 7113.110861142357, 5099.986578982787, 5108.770105345194, 5111.514406131411, 5128.1794912813775, 5278.023565640369, 5108.59131269505, 5127.769250383816, 5222.425533191422, 5234.084035293885, 5313.574914006947], "value": 4658.614287844557, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [308.48175065889296, 311.3042350346974, 317.1943264109163, 321.72331794656577, 332.03212635168484, 5530.695811730353, 5574.916376254359, 5713.571482138841, 5755.884882302356, 5783.219265399175, 5569.972150139254, 5635.6618602883855, 5635.774569017234, 5639.379668236491, 5642.689652069134, 4412.691111622188, 4421.911561768763, 4435.955640443586, 4441.111777644484, 4442.466903971512, 4349.956500434987, 4356.869293921171, 4378.978105109486, 4434.889127771799, 4447.933281000787, 4291.313389857623, 4297.419848320468, 4309.091363329756, 4317.7193482423545, 4345.8478953236645, 4149.33610622299, 4370.650347972155, 4372.103718737651, 4376.387305777162, 4395.582419670126, 3709.8330575124182, 3715.479832823407, 3720.479132921393, 3731.2724018816343, 3745.0, 5349.170878513836, 5409.540189083933, 5410.756515956791, 5418.972905135449, 5420.214068959979, 4750.0, 4850.781714822841, 4879.365682461257, 4904.6321525885705, 4924.409070911478, 5777.133429985493, 5808.912866307009, 5821.27234095738, 5835.883282334329, 5842.707864606795, 4120.835166593332, 4125.23683118624, 4132.483439570054, 4137.048478849852, 4137.91724165515, 5886.735096920649, 6100.389961003909, 6149.262088549358, 6150.5079593632845, 6151.569390142692, 4140.296149654566, 4156.709030367845, 4184.497860256728, 4193.853215137456, 4202.432671589358, 4245.936310955338, 4250.936235956463, 4268.914621707549, 4269.0, 4284.785760711952, 4807.61539076873, 4911.263310503382, 4917.237828136645, 4919.877003074952, 4952.356193694796, 5663.235463212496, 5864.794732184353, 5877.235959325346, 5896.6756828374855, 5916.970415147896, 1447.6898406941734, 1467.185711929889, 1467.611083062989, 1471.4261438039173, 1477.8989652708585, 898.9280857531381, 905.3391024551983, 931.9301052421096, 942.8350038743192, 946.6497395963538, 5054.646174767731, 5081.923771143436, 5118.38579370478, 5184.714840683799, 5185.611079169077, 5343.545798607084, 5358.624896257303, 5358.891842731285, 5395.304216611634, 5422.481705122572, 4872.926906096412, 5032.723200224023, 5055.34280543527, 5121.359830021247, 5144.742762861842, 2864.7851411144247, 2869.397426540408, 2869.569564565332, 2883.048593963987, 2906.7819913506573, 5428.348598168245, 5546.251256080458, 5597.524210442077, 5610.839826666681, 5616.9157462638095, 5197.766100525486, 5400.432954539795, 5418.997485465202, 5455.8363249102595, 5462.3445186577865, 5406.270153529302, 5498.697571633518, 5514.448555144453, 5531.6957567333375, 5558.0, 5186.196139598368, 5187.41783755958, 5281.498257665516, 5324.459234608942, 5359.169328754049, 5239.685618862881, 5338.519533242027, 5353.197020446964, 5364.624476286623, 5385.6230063895155, 5495.642783219078, 5505.522514868406, 5522.834314970557, 5560.694161820977, 5586.441355864381, 3804.372278574004, 3811.2187001665147, 3866.7099967501986, 3906.9609303907732, 4222.0, 5842.094475356326, 5915.349311575637, 6010.248718910137, 6118.888983300754, 6134.539909506716, 5813.157092221689, 5906.232189815297, 5914.260717410324, 5930.614510056833, 5947.9702601486715, 5857.326407463196, 5866.735996880236, 5869.501092407193, 5874.823755287348, 5889.175515427758, 5606.887862242814, 5681.715914204191, 5745.971270143623, 5762.761006383647, 5784.94215057844, 5850.2102216200265, 5905.025670764448, 5905.143754155709, 5946.929552680559, 5958.871592413844, 5511.641743286674, 5735.684537350486, 5742.310922689304, 5780.508656764222, 5835.533157347317], "value": 4291.383301318857, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [732.8497657980118, 767.1254769562697, 795.9164287749786, 802.169754304295, 813.9430239883211, 14595.708085838276, 15438.922805385986, 15580.0, 15662.530124096267, 15924.363025478982, 14435.783463248034, 14561.563153105424, 14571.417143314282, 14590.781138282935, 14600.342984565694, 797.1709422200904, 800.3277247112425, 801.5391150088693, 802.5906787538339, 814.311906439061, 811.4847072109224, 812.2162113560413, 816.481534225765, 818.9754307370758, 819.5041999590252, 842.1452225990624, 846.3990566697652, 846.6401779243828, 847.0978407995495, 848.2832006954145, 842.6629348260683, 843.026304618164, 843.0936743001298, 843.1568431568431, 844.2654890245526, 612.4946918792015, 612.5589575505629, 612.7334609444906, 613.6348872420903, 616.300498933709, 15052.473163439226, 15094.924525377302, 15138.318775655121, 15199.240037998166, 15213.0, 13697.931510342483, 13718.176909385369, 13999.650008749863, 14010.439582416691, 14153.066547432703, 11599.0, 11729.70675733105, 11741.88258117425, 11868.465919033664, 11906.940465297705, 3681.2140428544353, 3804.08701911542, 3828.9808550957346, 3876.2441323941844, 3939.409088636699, 73488.6325568374, 74486.62756686182, 75561.24438755542, 75575.0, 75761.0, 10739.248252622398, 10858.34849909008, 10932.836007459895, 10969.853232844172, 11087.778244435067, 19769.60460790776, 19790.604187916448, 19900.407967362575, 19941.401757947286, 20023.199072036954, 8412.158784121539, 8601.0, 8624.655013799504, 8741.431806932529, 8895.0, 4855.6601037927, 4911.656184067152, 4989.226669866177, 4991.800327986913, 5115.130427827278, 3489.2149266414854, 3601.0, 3619.4570814378053, 3622.800745958945, 3629.8003609801185, 630.4168644004369, 641.5477088652489, 647.8056583025074, 648.1185587600859, 666.8599594085297, 657.7303305644758, 686.5743239191634, 691.4261163234604, 692.3076923076923, 705.9823504412328, 9514.762130946781, 9756.268279878896, 9772.0, 9840.212782977345, 9873.80252394948, 549.9532539734088, 605.81825452365, 614.8954677704801, 662.8367215536798, 694.8506071194718, 4440.977795111004, 4532.841350552715, 4537.0925814837165, 4567.5432456754725, 4609.147307748078, 110330.0, 110731.0, 112706.05528806453, 113261.43369283265, 117290.0, 72706.63646681838, 81631.0, 97524.51237743908, 98313.0, 98340.50829745948, 84404.0, 85930.14069859346, 86251.56874215588, 87424.0, 87934.56032719795, 8004.879926801219, 8616.0, 8639.645634491086, 8710.259627931444, 8958.686445974621, 46058.53941460676, 51952.740236298574, 53291.46708532865, 53745.19382209192, 53792.19311710249, 70477.29522704707, 70596.64701676459, 71411.0, 72399.0, 75752.62123689346, 10759.569617215224, 10927.344359338465, 11546.13403994687, 11565.537378505102, 11827.172097953406, 12494.500219991098, 12534.749305014031, 12688.87311126877, 12709.872901270868, 12786.872131278567, 11640.476178571815, 11878.584249551224, 11893.821592675944, 12042.939785301018, 12672.74654506923, 11936.641900742992, 12261.0, 12296.508139674313, 12642.178258413174, 12651.683707907008, 11546.94226528862, 11760.70598235051, 11846.644600661994, 12039.63881083569, 12171.57399491049, 9940.706830433608, 9952.800943980936, 9978.850317245102, 10280.640177593748, 10570.947145264225, 9532.299754470912, 10297.639582614573, 10398.584056637952, 10403.843942341022, 10423.791524169626], "value": 7281.680823764487, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1541.0000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 105.0, 112.0, 110.0, 111.0, 112.0, 111.0, 109.0, 111.0, 113.0], "value": 110.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 125.0, 175.0, 174.0, 127.0, 160.0, 154.0, 130.0, 186.0, 125.0], "value": 151.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 163.0, 163.0, 162.0, 166.0, 174.0, 164.0, 163.0, 163.0], "value": 164.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 75.0, 167.0, 76.0, 76.0, 75.0, 75.0, 172.0, 76.0], "value": 94.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 84.0, 154.0, 85.0, 86.0, 85.0, 136.0, 85.0, 84.0, 157.0], "value": 104.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [120.0, 118.0, 117.0, 117.0, 117.0, 117.0, 118.0, 118.0, 117.0, 123.0], "value": 118.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 146.0, 146.0, 147.0, 148.0, 147.0, 147.0, 147.0, 148.0, 146.0], "value": 147.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 99.0, 96.0, 95.0, 95.0, 96.0, 95.0, 95.0], "value": 95.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 53.0, 56.0, 53.0, 53.0, 53.0, 55.0, 54.0, 54.0, 55.0], "value": 54.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 64.0, 62.0, 65.0, 64.0, 62.0, 63.0, 61.0, 62.0], "value": 62.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 87.0, 80.0, 81.0, 82.0, 84.0, 81.0, 82.0, 105.0, 91.0], "value": 85.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 121.0, 130.0, 122.0, 126.0, 132.0, 123.0, 128.0, 125.0, 132.0], "value": 126.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 159.0, 161.0, 166.0, 161.0, 167.0, 160.0, 158.0, 163.0, 173.0], "value": 163.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 64.0, 63.0, 63.0, 64.0, 65.0, 61.0, 63.0, 63.0, 62.0], "value": 63.6, "unit": "score"}]}]} 14:37:02 INFO - Return code: 0 14:37:03 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:37:03 ERROR - # TBPL SUCCESS # 14:37:03 INFO - Running post-action listener: _resource_record_post_action 14:37:03 INFO - ##### 14:37:03 INFO - ##### Finished run-tests step (success) 14:37:03 INFO - ##### 14:37:03 INFO - Running post-run listener: _resource_record_post_run 14:37:03 INFO - Total resource usage - Wall time: 1189s; CPU: 14.0%; Read bytes: 4096; Write bytes: 542965760; Read time: 24; Write time: 391628 14:37:03 INFO - TinderboxPrint: CPU usage
13.5% 14:37:03 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 24 14:37:03 INFO - TinderboxPrint: I/O write bytes / time
542,965,760 / 391,628 14:37:03 INFO - TinderboxPrint: CPU idle
8,202.8 (86.5%) 14:37:03 INFO - TinderboxPrint: CPU user
1,228.3 (12.9%) 14:37:03 INFO - TinderboxPrint: Swap in / out
0 / 0 14:37:03 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 248537088; Read time: 0; Write time: 227984 14:37:03 INFO - run-tests - Wall time: 1172s; CPU: 14.0%; Read bytes: 4096; Write bytes: 294428672; Read time: 24; Write time: 163644 14:37:03 INFO - Running post-run listener: _upload_blobber_files 14:37:03 INFO - Blob upload gear active. 14:37:03 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:37:03 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 14:37:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 14:37:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 14:37:04 INFO - (blobuploader) - INFO - Open directory for files ... 14:37:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 14:37:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:37:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:37:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 14:37:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:37:04 INFO - (blobuploader) - INFO - Done attempting. 14:37:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 14:37:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:37:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:37:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 14:37:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:37:06 INFO - (blobuploader) - INFO - Done attempting. 14:37:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:37:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:37:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:37:10 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:37:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:37:10 INFO - (blobuploader) - INFO - Done attempting. 14:37:10 INFO - (blobuploader) - INFO - Iteration through files over. 14:37:10 INFO - Return code: 0 14:37:10 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:37:10 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:37:10 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/03b2537afa05828f47723064d6d2c41e8d3b77aa7b257983c58050340721cc2d1a1ceb58cff15c42bfee31718764afe176f9b11a9cf6ee23c8a5699d13ca4443", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2f09c33e72ef4a1d169ca0e845dfbed3ab75e1da0035b5916b6fe541f57f45ee5635f4740c25e4dc1aef6095b9c82bb66809ecc9b2bc7e54efdc66cde9029d36", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e9f6dcd505a696e50bf03379b10e9a060ec22d52fecdc5623671396227551114c420e0619d35832eb9b53dc7a0f996b983ec57aeea56d06099b89efaab949d8c"} 14:37:10 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:37:10 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:37:10 INFO - Contents: 14:37:10 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/03b2537afa05828f47723064d6d2c41e8d3b77aa7b257983c58050340721cc2d1a1ceb58cff15c42bfee31718764afe176f9b11a9cf6ee23c8a5699d13ca4443", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2f09c33e72ef4a1d169ca0e845dfbed3ab75e1da0035b5916b6fe541f57f45ee5635f4740c25e4dc1aef6095b9c82bb66809ecc9b2bc7e54efdc66cde9029d36", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e9f6dcd505a696e50bf03379b10e9a060ec22d52fecdc5623671396227551114c420e0619d35832eb9b53dc7a0f996b983ec57aeea56d06099b89efaab949d8c"} 14:37:10 INFO - Running post-run listener: copy_logs_to_upload_dir 14:37:10 INFO - Copying logs to upload dir... 14:37:10 INFO - mkdir: /builds/slave/test/build/upload/logs 14:37:10 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1235.237433 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-06-04 14:37:09.142924) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-04 14:37:09.146852) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1465074753.892088-1917207659 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/03b2537afa05828f47723064d6d2c41e8d3b77aa7b257983c58050340721cc2d1a1ceb58cff15c42bfee31718764afe176f9b11a9cf6ee23c8a5699d13ca4443", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2f09c33e72ef4a1d169ca0e845dfbed3ab75e1da0035b5916b6fe541f57f45ee5635f4740c25e4dc1aef6095b9c82bb66809ecc9b2bc7e54efdc66cde9029d36", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e9f6dcd505a696e50bf03379b10e9a060ec22d52fecdc5623671396227551114c420e0619d35832eb9b53dc7a0f996b983ec57aeea56d06099b89efaab949d8c"} build_url:https://queue.taskcluster.net/v1/task/fYT15OJYTm6ZABxpOc7E4Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011514 build_url: 'https://queue.taskcluster.net/v1/task/fYT15OJYTm6ZABxpOc7E4Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/03b2537afa05828f47723064d6d2c41e8d3b77aa7b257983c58050340721cc2d1a1ceb58cff15c42bfee31718764afe176f9b11a9cf6ee23c8a5699d13ca4443", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2f09c33e72ef4a1d169ca0e845dfbed3ab75e1da0035b5916b6fe541f57f45ee5635f4740c25e4dc1aef6095b9c82bb66809ecc9b2bc7e54efdc66cde9029d36", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e9f6dcd505a696e50bf03379b10e9a060ec22d52fecdc5623671396227551114c420e0619d35832eb9b53dc7a0f996b983ec57aeea56d06099b89efaab949d8c"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-04 14:37:09.172216) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-04 14:37:09.172562) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1465074753.892088-1917207659 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004495 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-04 14:37:09.256417) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-04 14:37:09.256741) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-04 14:37:09.257089) ========= ========= Total master_lag: 0.17 =========