builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-055 starttime: 1470321900.25 results: success (0) buildid: 20160804070224 builduid: 8885a7337ab54fca97df0cf4c6f5bf2e revision: 5b972a509e33ad44c175354408ab6e3fce6c066c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-04 07:45:00.248101) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-04 07:45:00.248635) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-04 07:45:00.248977) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-04 07:45:00.289294) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-04 07:45:00.289624) ========= 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=bb9b54edd4a927dc735d112f000001d9-1470321745.808634-1729226070 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-04 07:45:00-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 224M=0s 2016-08-04 07:45:00 (224 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.086545 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-04 07:45:00.395329) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-04 07:45:00.395630) ========= 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=bb9b54edd4a927dc735d112f000001d9-1470321745.808634-1729226070 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014900 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-04 07:45:00.445293) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-04 07:45:00.445695) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 5b972a509e33ad44c175354408ab6e3fce6c066c --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 5b972a509e33ad44c175354408ab6e3fce6c066c --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=bb9b54edd4a927dc735d112f000001d9-1470321745.808634-1729226070 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-04 07:45:00,811 truncating revision to first 12 chars 2016-08-04 07:45:00,811 Setting DEBUG logging. 2016-08-04 07:45:00,811 attempt 1/10 2016-08-04 07:45:00,811 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/5b972a509e33?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-04 07:45:02,111 unpacking tar archive at: fx-team-5b972a509e33/testing/mozharness/ program finished with exit code 0 elapsedTime=1.643023 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-04 07:45:02.101779) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-04 07:45:02.102043) ========= script_repo_revision: 5b972a509e33ad44c175354408ab6e3fce6c066c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-04 07:45:02.102403) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-04 07:45:02.102660) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-04 07:45:02.110533) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-08-04 07:45:02.110889) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=bb9b54edd4a927dc735d112f000001d9-1470321745.808634-1729226070 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:45:02 INFO - MultiFileLogger online at 20160804 07:45:02 in /builds/slave/test 07:45:02 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 07:45:02 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:45:02 INFO - {'append_to_log': False, 07:45:02 INFO - 'base_work_dir': '/builds/slave/test', 07:45:02 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 07:45:02 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:45:02 INFO - 'branch': 'Fx-Team-Non-PGO', 07:45:02 INFO - 'buildbot_json_path': 'buildprops.json', 07:45:02 INFO - 'config_files': ('talos/linux_config.py',), 07:45:02 INFO - 'default_actions': ('clobber', 07:45:02 INFO - 'read-buildbot-config', 07:45:02 INFO - 'download-and-extract', 07:45:02 INFO - 'populate-webroot', 07:45:02 INFO - 'create-virtualenv', 07:45:02 INFO - 'install', 07:45:02 INFO - 'run-tests'), 07:45:02 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:45:02 INFO - 'download_minidump_stackwalk': True, 07:45:02 INFO - 'download_symbols': 'ondemand', 07:45:02 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:45:02 INFO - 'tooltool.py': '/tools/tooltool.py', 07:45:02 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:45:02 INFO - '/tools/misc-python/virtualenv.py')}, 07:45:02 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:45:02 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:45:02 INFO - 'installer_path': 'installer.exe', 07:45:02 INFO - 'log_level': 'info', 07:45:02 INFO - 'log_name': 'talos', 07:45:02 INFO - 'log_to_console': True, 07:45:02 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:45:02 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:45:02 INFO - 'opt_config_files': (), 07:45:02 INFO - 'pip_index': False, 07:45:02 INFO - 'sps_profile': False, 07:45:02 INFO - 'sps_profile_interval': 0, 07:45:02 INFO - 'suite': 'dromaeojs', 07:45:02 INFO - 'system_bits': '32', 07:45:02 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:45:02 INFO - 'title': 'talos-linux64-ix-055', 07:45:02 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:45:02 INFO - 'use_talos_json': True, 07:45:02 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:45:02 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:45:02 INFO - 'work_dir': 'build'} 07:45:02 INFO - [mozharness: 2016-08-04 14:45:02.566718Z] Running clobber step. 07:45:02 INFO - Running pre-action listener: _resource_record_pre_action 07:45:02 INFO - Running main action method: clobber 07:45:02 INFO - rmtree: /builds/slave/test/build 07:45:02 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:45:03 INFO - Running post-action listener: _resource_record_post_action 07:45:03 INFO - [mozharness: 2016-08-04 14:45:03.026266Z] Finished clobber step (success) 07:45:03 INFO - [mozharness: 2016-08-04 14:45:03.026368Z] Running read-buildbot-config step. 07:45:03 INFO - Running pre-action listener: _resource_record_pre_action 07:45:03 INFO - Running main action method: read_buildbot_config 07:45:03 INFO - Using buildbot properties: 07:45:03 INFO - { 07:45:03 INFO - "project": "", 07:45:03 INFO - "product": "firefox", 07:45:03 INFO - "script_repo_revision": "production", 07:45:03 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 07:45:03 INFO - "repository": "", 07:45:03 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 07:45:03 INFO - "buildid": "20160804070224", 07:45:03 INFO - "pgo_build": "False", 07:45:03 INFO - "basedir": "/builds/slave/test", 07:45:03 INFO - "buildnumber": 2067, 07:45:03 INFO - "slavename": "talos-linux64-ix-055", 07:45:03 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 07:45:03 INFO - "platform": "ubuntu64_hw", 07:45:03 INFO - "scheduler": "tests-fx-team-linux64-talos", 07:45:03 INFO - "branch": "fx-team", 07:45:03 INFO - "repo_path": "integration/fx-team", 07:45:03 INFO - "revision": "5b972a509e33ad44c175354408ab6e3fce6c066c", 07:45:03 INFO - "stage_platform": "linux64", 07:45:03 INFO - "builduid": "8885a7337ab54fca97df0cf4c6f5bf2e", 07:45:03 INFO - "slavebuilddir": "test" 07:45:03 INFO - } 07:45:03 INFO - Found installer url https://queue.taskcluster.net/v1/task/JBhRYW7uQVOgy35LGmTv1Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 07:45:03 INFO - Running post-action listener: _resource_record_post_action 07:45:03 INFO - [mozharness: 2016-08-04 14:45:03.028823Z] Finished read-buildbot-config step (success) 07:45:03 INFO - [mozharness: 2016-08-04 14:45:03.028913Z] Running download-and-extract step. 07:45:03 INFO - Running pre-action listener: _resource_record_pre_action 07:45:03 INFO - Running main action method: download_and_extract 07:45:03 INFO - mkdir: /builds/slave/test/build/tests 07:45: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')]} 07:45:03 INFO - https://queue.taskcluster.net/v1/task/JBhRYW7uQVOgy35LGmTv1Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 07:45:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JBhRYW7uQVOgy35LGmTv1Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 07:45:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JBhRYW7uQVOgy35LGmTv1Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 07:45:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JBhRYW7uQVOgy35LGmTv1Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 07:45:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JBhRYW7uQVOgy35LGmTv1Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 07:45:05 INFO - Downloaded 1361 bytes. 07:45:05 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 07:45:05 INFO - Using the following test package requirements: 07:45:05 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 07:45:05 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 07:45:05 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:45:05 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 07:45:05 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 07:45:05 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 07:45:05 INFO - u'jsshell-linux-x86_64.zip'], 07:45:05 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 07:45:05 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:45:05 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 07:45:05 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 07:45:05 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:45:05 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 07:45:05 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:45:05 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 07:45:05 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:45:05 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 07:45:05 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:45:05 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:45:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:45:05 INFO - https://queue.taskcluster.net/v1/task/JBhRYW7uQVOgy35LGmTv1Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:45:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JBhRYW7uQVOgy35LGmTv1Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 07:45:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JBhRYW7uQVOgy35LGmTv1Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 07:45:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JBhRYW7uQVOgy35LGmTv1Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 07:45:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JBhRYW7uQVOgy35LGmTv1Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:45:06 INFO - Downloaded 20241066 bytes. 07:45:06 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:45:06 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 07:45:07 INFO - Return code: 0 07:45:07 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 07:45:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:45:07 INFO - https://queue.taskcluster.net/v1/task/JBhRYW7uQVOgy35LGmTv1Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:45:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JBhRYW7uQVOgy35LGmTv1Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 07:45:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JBhRYW7uQVOgy35LGmTv1Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 07:45:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JBhRYW7uQVOgy35LGmTv1Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 07:45:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JBhRYW7uQVOgy35LGmTv1Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:45:08 INFO - Downloaded 20241066 bytes. 07:45:08 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:45:08 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 07:45:09 INFO - Return code: 0 07:45:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:45:09 INFO - https://queue.taskcluster.net/v1/task/JBhRYW7uQVOgy35LGmTv1Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 07:45:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JBhRYW7uQVOgy35LGmTv1Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 07:45:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JBhRYW7uQVOgy35LGmTv1Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 07:45:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JBhRYW7uQVOgy35LGmTv1Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 07:45:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JBhRYW7uQVOgy35LGmTv1Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 07:45:10 INFO - Downloaded 14413723 bytes. 07:45:10 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:45:10 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 07:45:11 INFO - Return code: 0 07:45:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:45:11 INFO - https://queue.taskcluster.net/v1/task/JBhRYW7uQVOgy35LGmTv1Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 07:45:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JBhRYW7uQVOgy35LGmTv1Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 07:45:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JBhRYW7uQVOgy35LGmTv1Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 07:45:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JBhRYW7uQVOgy35LGmTv1Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 07:45:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JBhRYW7uQVOgy35LGmTv1Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 07:45:12 INFO - Downloaded 55629578 bytes. 07:45:12 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/JBhRYW7uQVOgy35LGmTv1Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 07:45:12 INFO - mkdir: /builds/slave/test/properties 07:45:12 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:45:12 INFO - Writing to file /builds/slave/test/properties/build_url 07:45:12 INFO - Contents: 07:45:12 INFO - build_url:https://queue.taskcluster.net/v1/task/JBhRYW7uQVOgy35LGmTv1Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 07:45:13 INFO - Running post-action listener: _resource_record_post_action 07:45:13 INFO - Running post-action listener: set_extra_try_arguments 07:45:13 INFO - [mozharness: 2016-08-04 14:45:13.652011Z] Finished download-and-extract step (success) 07:45:13 INFO - [mozharness: 2016-08-04 14:45:13.652244Z] Running populate-webroot step. 07:45:13 INFO - Running pre-action listener: _resource_record_pre_action 07:45:13 INFO - Running main action method: populate_webroot 07:45:13 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:45:13 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:45:13 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:45:13 INFO - '--tppagecycles', 07:45:13 INFO - '7'], 07:45:13 INFO - 'tests': ['tsvgm']}}, 07:45:13 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:45:13 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:45:13 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:45:13 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:45:13 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:45:13 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:45:13 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:45:13 INFO - 'talos_options': ['--disable-e10s'], 07:45:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:45:13 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:45:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:45:13 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:45:13 INFO - 'talos_options': ['--disable-e10s'], 07:45:13 INFO - 'tests': ['damp', 'tps']}, 07:45:13 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:45:13 INFO - 'tests': ['damp', 'tps']}, 07:45:13 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:45:13 INFO - 'tests': ['dromaeo_dom']}, 07:45:13 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:45:13 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:45:13 INFO - 'tests': ['basic_compositor_video']}, 07:45:13 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:45:13 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:45:13 INFO - 'tests': ['a11yr', 07:45:13 INFO - 'ts_paint', 07:45:13 INFO - 'tpaint', 07:45:13 INFO - 'sessionrestore', 07:45:13 INFO - 'sessionrestore_no_auto_restore', 07:45:13 INFO - 'tabpaint']}, 07:45:13 INFO - 'other-e10s': {'tests': ['a11yr', 07:45:13 INFO - 'ts_paint', 07:45:13 INFO - 'tpaint', 07:45:13 INFO - 'sessionrestore', 07:45:13 INFO - 'sessionrestore_no_auto_restore', 07:45:13 INFO - 'tabpaint']}, 07:45:13 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:45:13 INFO - 'ts_paint', 07:45:13 INFO - 'tpaint', 07:45:13 INFO - 'sessionrestore', 07:45:13 INFO - 'sessionrestore_no_auto_restore', 07:45:13 INFO - 'tabpaint']}, 07:45:13 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:45:13 INFO - 'ts_paint', 07:45:13 INFO - 'tpaint', 07:45:13 INFO - 'sessionrestore', 07:45:13 INFO - 'sessionrestore_no_auto_restore', 07:45:13 INFO - 'tabpaint']}, 07:45:13 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:45:13 INFO - 'tests': ['a11yr', 07:45:13 INFO - 'ts_paint', 07:45:13 INFO - 'tpaint', 07:45:13 INFO - 'sessionrestore', 07:45:13 INFO - 'sessionrestore_no_auto_restore', 07:45:13 INFO - 'tabpaint']}, 07:45:13 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:45:13 INFO - 'tests': ['a11yr', 07:45:13 INFO - 'ts_paint', 07:45:13 INFO - 'tpaint', 07:45:13 INFO - 'sessionrestore', 07:45:13 INFO - 'sessionrestore_no_auto_restore', 07:45:13 INFO - 'tabpaint']}, 07:45:13 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:45:13 INFO - 'tests': ['tsvgx', 07:45:13 INFO - 'tsvgr_opacity', 07:45:13 INFO - 'tart', 07:45:13 INFO - 'tscrollx', 07:45:13 INFO - 'cart']}, 07:45:13 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:45:13 INFO - 'tsvgr_opacity', 07:45:13 INFO - 'tart', 07:45:13 INFO - 'tscrollx', 07:45:13 INFO - 'cart']}, 07:45:13 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:45:13 INFO - 'talos_options': ['--disable-e10s'], 07:45:13 INFO - 'tests': ['tp5o']}, 07:45:13 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:45:13 INFO - 'tests': ['tp5o']}, 07:45:13 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:45:13 INFO - 'talos_options': ['--disable-e10s', 07:45:13 INFO - '--xperf_path', 07:45:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:45:13 INFO - 'tests': ['tp5n']}, 07:45:13 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:45:13 INFO - 'talos_options': ['--xperf_path', 07:45:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:45:13 INFO - 'tests': ['tp5n']}}, 07:45:13 INFO - 'talos.zip': {'path': '', 07:45:13 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:45:13 INFO - Running post-action listener: _resource_record_post_action 07:45:13 INFO - [mozharness: 2016-08-04 14:45:13.674052Z] Finished populate-webroot step (success) 07:45:13 INFO - [mozharness: 2016-08-04 14:45:13.674141Z] Running create-virtualenv step. 07:45:13 INFO - Running pre-action listener: _resource_record_pre_action 07:45:13 INFO - Running main action method: create_virtualenv 07:45:13 INFO - Creating virtualenv /builds/slave/test/build/venv 07:45:13 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 07:45:13 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:45:13 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:45:13 INFO - Using real prefix '/usr' 07:45:13 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:45:14 INFO - Installing distribute.............................................................................................................................................................................................done. 07:45:16 INFO - Installing pip.................done. 07:45:16 INFO - Return code: 0 07:45:16 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:45:16 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')]} 07:45:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:45:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:45:16 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')]} 07:45:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:45:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:45:16 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 0x1d32030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e958a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ff3180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ff13b0>, '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 0x1ff22b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ff2740>, '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': 'bb9b54edd4a927dc735d112f000001d9-1470321745.808634-1729226070', '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 07:45:16 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 07:45:16 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 07:45:16 INFO - Using env: {'DISPLAY': ':0', 07:45:16 INFO - 'HOME': '/home/cltbld', 07:45:16 INFO - 'LANG': 'en_US.UTF-8', 07:45:16 INFO - 'LANGUAGE': 'en_US:en', 07:45:16 INFO - 'LOGNAME': 'cltbld', 07:45:16 INFO - 'MAIL': '/var/mail/cltbld', 07:45:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:45:16 INFO - 'MOZ_NO_REMOTE': '1', 07:45:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:45:16 INFO - 'NO_EM_RESTART': '1', 07:45:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:45:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:45:16 INFO - 'PWD': '/builds/slave/test', 07:45:16 INFO - 'SHELL': '/bin/bash', 07:45:16 INFO - 'SHLVL': '1', 07:45:16 INFO - 'TERM': 'linux', 07:45:16 INFO - 'TMOUT': '86400', 07:45:16 INFO - 'USER': 'cltbld', 07:45:16 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1470321745.808634-1729226070', 07:45:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:45:16 INFO - '_': '/tools/buildbot/bin/python'} 07:45:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:45:16 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 07:45:16 INFO - Cleaning up... 07:45:16 INFO - Return code: 0 07:45:16 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:45:16 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')]} 07:45:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:45:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:45:16 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')]} 07:45:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:45:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:45:16 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 0x1d32030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e958a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ff3180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ff13b0>, '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 0x1ff22b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ff2740>, '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': 'bb9b54edd4a927dc735d112f000001d9-1470321745.808634-1729226070', '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 07:45:16 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 07:45:16 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 07:45:16 INFO - Using env: {'DISPLAY': ':0', 07:45:16 INFO - 'HOME': '/home/cltbld', 07:45:16 INFO - 'LANG': 'en_US.UTF-8', 07:45:16 INFO - 'LANGUAGE': 'en_US:en', 07:45:16 INFO - 'LOGNAME': 'cltbld', 07:45:16 INFO - 'MAIL': '/var/mail/cltbld', 07:45:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:45:16 INFO - 'MOZ_NO_REMOTE': '1', 07:45:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:45:16 INFO - 'NO_EM_RESTART': '1', 07:45:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:45:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:45:16 INFO - 'PWD': '/builds/slave/test', 07:45:16 INFO - 'SHELL': '/bin/bash', 07:45:16 INFO - 'SHLVL': '1', 07:45:16 INFO - 'TERM': 'linux', 07:45:16 INFO - 'TMOUT': '86400', 07:45:16 INFO - 'USER': 'cltbld', 07:45:16 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1470321745.808634-1729226070', 07:45:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:45:16 INFO - '_': '/tools/buildbot/bin/python'} 07:45:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:45:16 INFO - Downloading/unpacking psutil>=3.1.1 07:45:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:45:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:45:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:45:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:45:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:45:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:45:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:45:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:45:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:45:18 INFO - Installing collected packages: psutil 07:45:18 INFO - Running setup.py install for psutil 07:45:18 INFO - building 'psutil._psutil_linux' extension 07:45:18 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 07:45:18 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 07:45:18 INFO - building 'psutil._psutil_posix' extension 07:45:18 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 07:45:19 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 07:45:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:45:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:45:19 INFO - Successfully installed psutil 07:45:19 INFO - Cleaning up... 07:45:19 INFO - Return code: 0 07:45:19 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:45:19 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')]} 07:45:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:45:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:45:19 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')]} 07:45:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:45:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:45:19 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 0x1d32030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e958a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ff3180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ff13b0>, '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 0x1ff22b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ff2740>, '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': 'bb9b54edd4a927dc735d112f000001d9-1470321745.808634-1729226070', '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 07:45:19 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 07:45:19 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 07:45:19 INFO - Using env: {'DISPLAY': ':0', 07:45:19 INFO - 'HOME': '/home/cltbld', 07:45:19 INFO - 'LANG': 'en_US.UTF-8', 07:45:19 INFO - 'LANGUAGE': 'en_US:en', 07:45:19 INFO - 'LOGNAME': 'cltbld', 07:45:19 INFO - 'MAIL': '/var/mail/cltbld', 07:45:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:45:19 INFO - 'MOZ_NO_REMOTE': '1', 07:45:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:45:19 INFO - 'NO_EM_RESTART': '1', 07:45:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:45:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:45:19 INFO - 'PWD': '/builds/slave/test', 07:45:19 INFO - 'SHELL': '/bin/bash', 07:45:19 INFO - 'SHLVL': '1', 07:45:19 INFO - 'TERM': 'linux', 07:45:19 INFO - 'TMOUT': '86400', 07:45:19 INFO - 'USER': 'cltbld', 07:45:19 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1470321745.808634-1729226070', 07:45:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:45:19 INFO - '_': '/tools/buildbot/bin/python'} 07:45:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:45:19 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:45:19 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 07:45:19 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 07:45:19 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 07:45:19 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 07:45:19 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 07:45:19 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 07:45:21 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:45:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:45:21 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:45:21 INFO - Installing collected packages: mozsystemmonitor 07:45:21 INFO - Running setup.py install for mozsystemmonitor 07:45:21 INFO - Successfully installed mozsystemmonitor 07:45:21 INFO - Cleaning up... 07:45:21 INFO - Return code: 0 07:45:21 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:45:21 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')]} 07:45:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:45:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:45:21 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')]} 07:45:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:45:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:45:21 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 0x1d32030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e958a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ff3180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ff13b0>, '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 0x1ff22b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ff2740>, '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': 'bb9b54edd4a927dc735d112f000001d9-1470321745.808634-1729226070', '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 07:45:21 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 07:45:21 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 07:45:21 INFO - Using env: {'DISPLAY': ':0', 07:45:21 INFO - 'HOME': '/home/cltbld', 07:45:21 INFO - 'LANG': 'en_US.UTF-8', 07:45:21 INFO - 'LANGUAGE': 'en_US:en', 07:45:21 INFO - 'LOGNAME': 'cltbld', 07:45:21 INFO - 'MAIL': '/var/mail/cltbld', 07:45:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:45:21 INFO - 'MOZ_NO_REMOTE': '1', 07:45:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:45:21 INFO - 'NO_EM_RESTART': '1', 07:45:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:45:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:45:21 INFO - 'PWD': '/builds/slave/test', 07:45:21 INFO - 'SHELL': '/bin/bash', 07:45:21 INFO - 'SHLVL': '1', 07:45:21 INFO - 'TERM': 'linux', 07:45:21 INFO - 'TMOUT': '86400', 07:45:21 INFO - 'USER': 'cltbld', 07:45:21 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1470321745.808634-1729226070', 07:45:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:45:21 INFO - '_': '/tools/buildbot/bin/python'} 07:45:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:45:21 INFO - Downloading/unpacking jsonschema==2.5.1 07:45:21 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 07:45:21 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 07:45:21 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 07:45:21 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 07:45:21 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 07:45:21 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 07:45:23 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:45:23 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:45:23 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 07:45:23 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 07:45:23 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 07:45:23 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 07:45:23 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 07:45:23 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 07:45:23 INFO - Downloading functools32-3.2.3-2.tar.gz 07:45:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:45:23 INFO - warning: no files found matching '*.txt' 07:45:23 INFO - no previously-included directories found matching 'build' 07:45:23 INFO - no previously-included directories found matching 'dist' 07:45:23 INFO - no previously-included directories found matching '.git*' 07:45:23 INFO - Installing collected packages: jsonschema, functools32 07:45:23 INFO - Running setup.py install for functools32 07:45:23 INFO - warning: no files found matching '*.txt' 07:45:23 INFO - no previously-included directories found matching 'build' 07:45:23 INFO - no previously-included directories found matching 'dist' 07:45:23 INFO - no previously-included directories found matching '.git*' 07:45:24 INFO - Successfully installed jsonschema functools32 07:45:24 INFO - Cleaning up... 07:45:24 INFO - Return code: 0 07:45:24 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:45:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:45:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:45:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:45:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:45:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:45:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:45:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d32030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e958a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ff3180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ff13b0>, '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 0x1ff22b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ff2740>, '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': 'bb9b54edd4a927dc735d112f000001d9-1470321745.808634-1729226070', '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 07:45:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 07:45:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 07:45:24 INFO - Using env: {'DISPLAY': ':0', 07:45:24 INFO - 'HOME': '/home/cltbld', 07:45:24 INFO - 'LANG': 'en_US.UTF-8', 07:45:24 INFO - 'LANGUAGE': 'en_US:en', 07:45:24 INFO - 'LOGNAME': 'cltbld', 07:45:24 INFO - 'MAIL': '/var/mail/cltbld', 07:45:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:45:24 INFO - 'MOZ_NO_REMOTE': '1', 07:45:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:45:24 INFO - 'NO_EM_RESTART': '1', 07:45:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:45:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:45:24 INFO - 'PWD': '/builds/slave/test', 07:45:24 INFO - 'SHELL': '/bin/bash', 07:45:24 INFO - 'SHLVL': '1', 07:45:24 INFO - 'TERM': 'linux', 07:45:24 INFO - 'TMOUT': '86400', 07:45:24 INFO - 'USER': 'cltbld', 07:45:24 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1470321745.808634-1729226070', 07:45:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:45:24 INFO - '_': '/tools/buildbot/bin/python'} 07:45:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:45:24 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:45:24 INFO - Cleaning up... 07:45:24 INFO - Return code: 0 07:45:24 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:45:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:45:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:45:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:45:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:45:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:45:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:45:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1d32030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e958a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ff3180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ff13b0>, '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 0x1ff22b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ff2740>, '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': 'bb9b54edd4a927dc735d112f000001d9-1470321745.808634-1729226070', '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 07:45:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 07:45:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 07:45:24 INFO - Using env: {'DISPLAY': ':0', 07:45:24 INFO - 'HOME': '/home/cltbld', 07:45:24 INFO - 'LANG': 'en_US.UTF-8', 07:45:24 INFO - 'LANGUAGE': 'en_US:en', 07:45:24 INFO - 'LOGNAME': 'cltbld', 07:45:24 INFO - 'MAIL': '/var/mail/cltbld', 07:45:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:45:24 INFO - 'MOZ_NO_REMOTE': '1', 07:45:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:45:24 INFO - 'NO_EM_RESTART': '1', 07:45:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:45:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:45:24 INFO - 'PWD': '/builds/slave/test', 07:45:24 INFO - 'SHELL': '/bin/bash', 07:45:24 INFO - 'SHLVL': '1', 07:45:24 INFO - 'TERM': 'linux', 07:45:24 INFO - 'TMOUT': '86400', 07:45:24 INFO - 'USER': 'cltbld', 07:45:24 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1470321745.808634-1729226070', 07:45:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:45:24 INFO - '_': '/tools/buildbot/bin/python'} 07:45:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:45:24 INFO - Downloading/unpacking blobuploader==1.2.4 07:45:24 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 07:45:24 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 07:45:24 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 07:45:24 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 07:45:24 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 07:45:24 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 07:45:26 INFO - Downloading blobuploader-1.2.4.tar.gz 07:45:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:45:26 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:45:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:45:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:45:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:45:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:45:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:45:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:45:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:45:26 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:45:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:45:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:45:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:45:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:45:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:45:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:45:27 INFO - Downloading docopt-0.6.1.tar.gz 07:45:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:45:27 INFO - Installing collected packages: blobuploader, requests, docopt 07:45:27 INFO - Running setup.py install for blobuploader 07:45:27 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:45:27 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:45:27 INFO - Running setup.py install for requests 07:45:27 INFO - Running setup.py install for docopt 07:45:27 INFO - Successfully installed blobuploader requests docopt 07:45:27 INFO - Cleaning up... 07:45:27 INFO - Return code: 0 07:45:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:45:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:45:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:45:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:45:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:45:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:45:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:45:27 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 0x1d32030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e958a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ff3180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ff13b0>, '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 0x1ff22b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ff2740>, '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': 'bb9b54edd4a927dc735d112f000001d9-1470321745.808634-1729226070', '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 07:45:27 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 07:45:27 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 07:45:27 INFO - Using env: {'DISPLAY': ':0', 07:45:27 INFO - 'HOME': '/home/cltbld', 07:45:27 INFO - 'LANG': 'en_US.UTF-8', 07:45:27 INFO - 'LANGUAGE': 'en_US:en', 07:45:27 INFO - 'LOGNAME': 'cltbld', 07:45:27 INFO - 'MAIL': '/var/mail/cltbld', 07:45:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:45:27 INFO - 'MOZ_NO_REMOTE': '1', 07:45:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:45:27 INFO - 'NO_EM_RESTART': '1', 07:45:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:45:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:45:27 INFO - 'PWD': '/builds/slave/test', 07:45:27 INFO - 'SHELL': '/bin/bash', 07:45:27 INFO - 'SHLVL': '1', 07:45:27 INFO - 'TERM': 'linux', 07:45:27 INFO - 'TMOUT': '86400', 07:45:27 INFO - 'USER': 'cltbld', 07:45:27 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1470321745.808634-1729226070', 07:45:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:45:27 INFO - '_': '/tools/buildbot/bin/python'} 07:45:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:45:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:45:27 INFO - Running setup.py (path:/tmp/pip-gGLdKw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:45:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:45:28 INFO - Running setup.py (path:/tmp/pip-i_jCiH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:45:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:45:28 INFO - Running setup.py (path:/tmp/pip-A5yIyg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:45:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:45:28 INFO - Running setup.py (path:/tmp/pip-mTD3V2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:45:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:45:28 INFO - Running setup.py (path:/tmp/pip-2e6PYM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:45:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:45:28 INFO - Running setup.py (path:/tmp/pip-c26apo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:45:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:45:28 INFO - Running setup.py (path:/tmp/pip-i3s6Uq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:45:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:45:28 INFO - Running setup.py (path:/tmp/pip-VB0peM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:45:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:45:28 INFO - Running setup.py (path:/tmp/pip-mqtlqF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:45:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:45:28 INFO - Running setup.py (path:/tmp/pip-kgrQAk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:45:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:45:28 INFO - Running setup.py (path:/tmp/pip-MSMTRi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:45:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:45:28 INFO - Running setup.py (path:/tmp/pip-riabmk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:45:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:45:28 INFO - Running setup.py (path:/tmp/pip-DJsEek-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:45:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:45:28 INFO - Running setup.py (path:/tmp/pip-IpE_pS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:45:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:45:28 INFO - Running setup.py (path:/tmp/pip-n5fUVy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:45:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:45:29 INFO - Running setup.py (path:/tmp/pip-5DpIjl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:45:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:45:29 INFO - Running setup.py (path:/tmp/pip-IzAKxC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:45:29 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:45:29 INFO - Running setup.py install for manifestparser 07:45:29 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:45:29 INFO - Running setup.py install for mozcrash 07:45:29 INFO - Running setup.py install for mozdebug 07:45:29 INFO - Running setup.py install for mozdevice 07:45:29 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:45:29 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:45:29 INFO - Running setup.py install for mozfile 07:45:29 INFO - Running setup.py install for mozhttpd 07:45:29 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:45:29 INFO - Running setup.py install for mozinfo 07:45:29 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:45:29 INFO - Running setup.py install for mozInstall 07:45:29 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:45:29 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:45:29 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:45:29 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:45:29 INFO - Running setup.py install for mozleak 07:45:30 INFO - Running setup.py install for mozlog 07:45:30 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:45:30 INFO - Running setup.py install for moznetwork 07:45:30 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:45:30 INFO - Running setup.py install for mozprocess 07:45:30 INFO - Running setup.py install for mozprofile 07:45:30 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:45:30 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:45:30 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:45:30 INFO - Running setup.py install for mozrunner 07:45:30 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:45:30 INFO - Running setup.py install for mozscreenshot 07:45:30 INFO - Running setup.py install for moztest 07:45:30 INFO - Running setup.py install for mozversion 07:45:30 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:45:30 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:45:30 INFO - Cleaning up... 07:45:30 INFO - Return code: 0 07:45:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:45: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')]} 07:45:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:45:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:45: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')]} 07:45:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:45:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:45:30 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 0x1d32030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e958a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ff3180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ff13b0>, '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 0x1ff22b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ff2740>, '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': 'bb9b54edd4a927dc735d112f000001d9-1470321745.808634-1729226070', '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 07:45:30 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 07:45:30 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 07:45:30 INFO - Using env: {'DISPLAY': ':0', 07:45:30 INFO - 'HOME': '/home/cltbld', 07:45:30 INFO - 'LANG': 'en_US.UTF-8', 07:45:30 INFO - 'LANGUAGE': 'en_US:en', 07:45:30 INFO - 'LOGNAME': 'cltbld', 07:45:30 INFO - 'MAIL': '/var/mail/cltbld', 07:45:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:45:30 INFO - 'MOZ_NO_REMOTE': '1', 07:45:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:45:30 INFO - 'NO_EM_RESTART': '1', 07:45:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:45:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:45:30 INFO - 'PWD': '/builds/slave/test', 07:45:30 INFO - 'SHELL': '/bin/bash', 07:45:30 INFO - 'SHLVL': '1', 07:45:30 INFO - 'TERM': 'linux', 07:45:30 INFO - 'TMOUT': '86400', 07:45:30 INFO - 'USER': 'cltbld', 07:45:30 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1470321745.808634-1729226070', 07:45:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:45:30 INFO - '_': '/tools/buildbot/bin/python'} 07:45:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:45:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:45:31 INFO - Running setup.py (path:/tmp/pip-2ApzLa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:45:31 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)) 07:45:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:45:31 INFO - Running setup.py (path:/tmp/pip-D6mUNK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:45:31 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)) 07:45:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:45:31 INFO - Running setup.py (path:/tmp/pip-F1FZ74-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:45:31 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)) 07:45:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:45:31 INFO - Running setup.py (path:/tmp/pip-JRoORf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:45:31 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)) 07:45:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:45:31 INFO - Running setup.py (path:/tmp/pip-zTmRYk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:45:31 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)) 07:45:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:45:31 INFO - Running setup.py (path:/tmp/pip-44Lf5u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:45:31 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)) 07:45:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:45:31 INFO - Running setup.py (path:/tmp/pip-LuO0Xp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:45:31 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)) 07:45:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:45:31 INFO - Running setup.py (path:/tmp/pip-XcsDjg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:45:31 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)) 07:45:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:45:31 INFO - Running setup.py (path:/tmp/pip-wnSBvv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:45:31 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)) 07:45:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:45:31 INFO - Running setup.py (path:/tmp/pip-eLz48d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:45:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 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)) 07:45:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:45:31 INFO - Running setup.py (path:/tmp/pip-6MSfnd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:45:31 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)) 07:45:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:45:31 INFO - Running setup.py (path:/tmp/pip-ujfpkZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:45:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 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)) 07:45:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:45:32 INFO - Running setup.py (path:/tmp/pip-GUaMpo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:45:32 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)) 07:45:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:45:32 INFO - Running setup.py (path:/tmp/pip-SOcDXA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:45:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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)) 07:45:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:45:32 INFO - Running setup.py (path:/tmp/pip-wfjPwp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:45:32 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)) 07:45:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:45:32 INFO - Running setup.py (path:/tmp/pip-njBbqo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:45:32 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)) 07:45:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:45:32 INFO - Running setup.py (path:/tmp/pip-_glzHB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:45:32 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)) 07:45:32 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)) 07:45:32 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)) 07:45:32 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)) 07:45:32 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)) 07:45:32 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)) 07:45:32 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:45:32 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 07:45:32 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 07:45:32 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 07:45:32 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 07:45:32 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 07:45:32 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 07:45:34 INFO - Downloading blessings-1.6.tar.gz 07:45:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:45:34 INFO - Installing collected packages: blessings 07:45:34 INFO - Running setup.py install for blessings 07:45:34 INFO - Successfully installed blessings 07:45:34 INFO - Cleaning up... 07:45:34 INFO - Return code: 0 07:45:34 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:45:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:45:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:45:34 INFO - Reading from file tmpfile_stdout 07:45:34 INFO - Current package versions: 07:45:34 INFO - argparse == 1.2.1 07:45:34 INFO - blessings == 1.6 07:45:34 INFO - blobuploader == 1.2.4 07:45:34 INFO - docopt == 0.6.1 07:45:34 INFO - functools32 == 3.2.3-2 07:45:34 INFO - jsonschema == 2.5.1 07:45:34 INFO - manifestparser == 1.1 07:45:34 INFO - mozInstall == 1.12 07:45:34 INFO - mozcrash == 0.17 07:45:34 INFO - mozdebug == 0.1 07:45:34 INFO - mozdevice == 0.48 07:45:34 INFO - mozfile == 1.2 07:45:34 INFO - mozhttpd == 0.7 07:45:34 INFO - mozinfo == 0.9 07:45:34 INFO - mozleak == 0.1 07:45:34 INFO - mozlog == 3.3 07:45:34 INFO - moznetwork == 0.27 07:45:34 INFO - mozprocess == 0.23 07:45:34 INFO - mozprofile == 0.28 07:45:34 INFO - mozrunner == 6.12 07:45:34 INFO - mozscreenshot == 0.1 07:45:34 INFO - mozsystemmonitor == 0.3 07:45:34 INFO - moztest == 0.7 07:45:34 INFO - mozversion == 1.4 07:45:34 INFO - psutil == 3.1.1 07:45:34 INFO - requests == 1.2.3 07:45:34 INFO - wsgiref == 0.1.2 07:45:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:45:34 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')]} 07:45:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:45:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:45:34 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')]} 07:45:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:45:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:45:34 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 0x1d32030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e958a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ff3180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ff13b0>, '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 0x1ff22b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ff2740>, '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': 'bb9b54edd4a927dc735d112f000001d9-1470321745.808634-1729226070', '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 07:45:34 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 07:45:34 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 07:45:34 INFO - Using env: {'DISPLAY': ':0', 07:45:34 INFO - 'HOME': '/home/cltbld', 07:45:34 INFO - 'LANG': 'en_US.UTF-8', 07:45:34 INFO - 'LANGUAGE': 'en_US:en', 07:45:34 INFO - 'LOGNAME': 'cltbld', 07:45:34 INFO - 'MAIL': '/var/mail/cltbld', 07:45:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:45:34 INFO - 'MOZ_NO_REMOTE': '1', 07:45:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:45:34 INFO - 'NO_EM_RESTART': '1', 07:45:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:45:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:45:34 INFO - 'PWD': '/builds/slave/test', 07:45:34 INFO - 'SHELL': '/bin/bash', 07:45:34 INFO - 'SHLVL': '1', 07:45:34 INFO - 'TERM': 'linux', 07:45:34 INFO - 'TMOUT': '86400', 07:45:34 INFO - 'USER': 'cltbld', 07:45:34 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1470321745.808634-1729226070', 07:45:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:45:34 INFO - '_': '/tools/buildbot/bin/python'} 07:45:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:45:34 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)) 07:45:34 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)) 07:45:34 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)) 07:45:34 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)) 07:45:34 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)) 07:45:34 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)) 07:45:34 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)) 07:45:34 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)) 07:45:34 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)) 07:45:34 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)) 07:45:34 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)) 07:45:34 INFO - Cleaning up... 07:45:34 INFO - Return code: 0 07:45:34 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:45:34 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')]} 07:45:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:45:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:45:34 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')]} 07:45:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:45:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:45:34 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 0x1d32030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e958a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ff3180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ff13b0>, '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 0x1ff22b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ff2740>, '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': 'bb9b54edd4a927dc735d112f000001d9-1470321745.808634-1729226070', '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 07:45:34 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 07:45:34 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 07:45:34 INFO - Using env: {'DISPLAY': ':0', 07:45:34 INFO - 'HOME': '/home/cltbld', 07:45:34 INFO - 'LANG': 'en_US.UTF-8', 07:45:34 INFO - 'LANGUAGE': 'en_US:en', 07:45:34 INFO - 'LOGNAME': 'cltbld', 07:45:34 INFO - 'MAIL': '/var/mail/cltbld', 07:45:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:45:34 INFO - 'MOZ_NO_REMOTE': '1', 07:45:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:45:34 INFO - 'NO_EM_RESTART': '1', 07:45:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:45:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:45:34 INFO - 'PWD': '/builds/slave/test', 07:45:34 INFO - 'SHELL': '/bin/bash', 07:45:34 INFO - 'SHLVL': '1', 07:45:34 INFO - 'TERM': 'linux', 07:45:34 INFO - 'TMOUT': '86400', 07:45:34 INFO - 'USER': 'cltbld', 07:45:34 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1470321745.808634-1729226070', 07:45:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:45:34 INFO - '_': '/tools/buildbot/bin/python'} 07:45:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:45:35 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:45:35 INFO - Cleaning up... 07:45:35 INFO - Return code: 0 07:45:35 INFO - Running post-action listener: _resource_record_post_action 07:45:35 INFO - Running post-action listener: _start_resource_monitoring 07:45:35 INFO - Starting resource monitoring. 07:45:35 INFO - [mozharness: 2016-08-04 14:45:35.224249Z] Finished create-virtualenv step (success) 07:45:35 INFO - [mozharness: 2016-08-04 14:45:35.224729Z] Running install step. 07:45:35 INFO - Running pre-action listener: _resource_record_pre_action 07:45:35 INFO - Running main action method: install 07:45:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:45:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:45:35 INFO - Reading from file tmpfile_stdout 07:45:35 INFO - Detecting whether we're running mozinstall >=1.0... 07:45:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:45:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:45:35 INFO - Reading from file tmpfile_stdout 07:45:35 INFO - Output received: 07:45:35 INFO - Usage: mozinstall [options] installer 07:45:35 INFO - Options: 07:45:35 INFO - -h, --help show this help message and exit 07:45:35 INFO - -d DEST, --destination=DEST 07:45:35 INFO - Directory to install application into. [default: 07:45:35 INFO - "/builds/slave/test"] 07:45:35 INFO - --app=APP Application being installed. [default: firefox] 07:45:35 INFO - mkdir: /builds/slave/test/build/application 07:45:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 07:45:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 07:45:51 INFO - Reading from file tmpfile_stdout 07:45:51 INFO - Output received: 07:45:51 INFO - /builds/slave/test/build/application/firefox/firefox 07:45:51 INFO - Running post-action listener: _resource_record_post_action 07:45:51 INFO - [mozharness: 2016-08-04 14:45:51.514726Z] Finished install step (success) 07:45:51 INFO - [mozharness: 2016-08-04 14:45:51.515003Z] Running run-tests step. 07:45:51 INFO - Running pre-action listener: _resource_record_pre_action 07:45:51 INFO - Running main action method: run_tests 07:45:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:45:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:45:51 INFO - Python 2.7.3 07:45:51 INFO - Return code: 0 07:45:51 INFO - grabbing minidump binary from tooltool 07:45: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')]} 07:45:51 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 0x1ff13b0>, '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 0x1ff22b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ff2740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:45:51 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 07:45:51 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 07:45:51 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 07:45:51 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:45:51 INFO - Return code: 0 07:45:51 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:45:51 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:45:51 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:45:51 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:45:51 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:45:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JBhRYW7uQVOgy35LGmTv1Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-055', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 07:45:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/JBhRYW7uQVOgy35LGmTv1Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-055 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 07:45:51 INFO - Using env: {'DISPLAY': ':0', 07:45:51 INFO - 'HOME': '/home/cltbld', 07:45:51 INFO - 'LANG': 'en_US.UTF-8', 07:45:51 INFO - 'LANGUAGE': 'en_US:en', 07:45:51 INFO - 'LOGNAME': 'cltbld', 07:45:51 INFO - 'MAIL': '/var/mail/cltbld', 07:45:51 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:45:51 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:45:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:45:51 INFO - 'MOZ_NO_REMOTE': '1', 07:45:51 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:45:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:45:51 INFO - 'NO_EM_RESTART': '1', 07:45:51 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:45:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:45:51 INFO - 'PWD': '/builds/slave/test', 07:45:51 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:45:51 INFO - 'SHELL': '/bin/bash', 07:45:51 INFO - 'SHLVL': '1', 07:45:51 INFO - 'TERM': 'linux', 07:45:51 INFO - 'TMOUT': '86400', 07:45:51 INFO - 'USER': 'cltbld', 07:45:51 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1470321745.808634-1729226070', 07:45:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:45:51 INFO - '_': '/tools/buildbot/bin/python'} 07:45:51 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JBhRYW7uQVOgy35LGmTv1Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-055', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 07:45:51 INFO - mozversion application_buildid: 20160804070224 07:45:51 INFO - mozversion application_changeset: 5b972a509e33ad44c175354408ab6e3fce6c066c 07:45:51 INFO - mozversion application_display_name: Nightly 07:45:51 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:45:51 INFO - mozversion application_name: Firefox 07:45:51 INFO - mozversion application_remotingname: firefox 07:45:51 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 07:45:51 INFO - mozversion application_vendor: Mozilla 07:45:51 INFO - mozversion application_version: 51.0a1 07:45:51 INFO - mozversion platform_buildid: 20160804070224 07:45:51 INFO - mozversion platform_changeset: 5b972a509e33ad44c175354408ab6e3fce6c066c 07:45:51 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 07:45:51 INFO - mozversion platform_version: 51.0a1 07:45:51 INFO - using testdate: 1470321951 07:45:51 INFO - actual date: 1470321951 07:45:51 INFO - starting webserver on 'localhost:35890' 07:45:51 INFO - SUITE-START | Running 2 tests 07:45:51 INFO - TEST-START | dromaeo_css 07:45:51 INFO - operating with platform_type : linux_ 07:45:51 INFO - Initialising browser for dromaeo_css test... 07:45:51 INFO - TEST-INFO | started process 29519 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQk5z1J/profile http://localhost:35890/getInfo.html) 07:45:56 INFO - PROCESS | 29519 | __metrics Screen width/height:1600/1200 07:45:56 INFO - PROCESS | 29519 | colorDepth:24 07:45:56 INFO - PROCESS | 29519 | Browser inner width/height: 1024/697 07:45:56 INFO - PROCESS | 29519 | __metrics 07:45:56 INFO - PROCESS | 29519 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 07:45:56 INFO - PROCESS | 29519 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:45:58 INFO - TEST-INFO | 29519: exit 0 07:45:58 INFO - Browser initialized. 07:45:58 INFO - Running cycle 1/1 for dromaeo_css test... 07:45:58 INFO - TEST-INFO | started process 29597 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQk5z1J/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:46:09 INFO - PROCESS | 29597 | RSS: Main: 157609984 07:46:09 INFO - PROCESS | 29597 | 07:47:01 INFO - PROCESS | 29597 | 1470322021562 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] 07:49:14 INFO - PROCESS | 29597 | Cycle 1(1): loaded http://localhost:35890/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35890/tests/dromaeo/cssquery-ext.html) 07:49:15 INFO - PROCESS | 29597 | RSS: Main: 253358080 07:49:15 INFO - PROCESS | 29597 | 07:52:18 INFO - PROCESS | 29597 | Cycle 1(1): loaded http://localhost:35890/tests/dromaeo/cssquery-ext.html (next: http://localhost:35890/tests/dromaeo/cssquery-jquery.html) 07:52:19 INFO - PROCESS | 29597 | RSS: Main: 249151488 07:52:19 INFO - PROCESS | 29597 | 07:55:21 INFO - PROCESS | 29597 | Cycle 1(1): loaded http://localhost:35890/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35890/tests/dromaeo/cssquery-mootools.html) 07:55:21 INFO - PROCESS | 29597 | RSS: Main: 188837888 07:55:21 INFO - PROCESS | 29597 | 07:58:24 INFO - PROCESS | 29597 | Cycle 1(1): loaded http://localhost:35890/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35890/tests/dromaeo/cssquery-prototype.html) 07:58:24 INFO - PROCESS | 29597 | RSS: Main: 188866560 07:58:24 INFO - PROCESS | 29597 | 08:01:27 INFO - PROCESS | 29597 | Cycle 1(1): loaded http://localhost:35890/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35890/tests/dromaeo/cssquery-yui.html) 08:01:28 INFO - PROCESS | 29597 | RSS: Main: 188694528 08:01:28 INFO - PROCESS | 29597 | 08:04:31 INFO - PROCESS | 29597 | Cycle 1(1): loaded http://localhost:35890/tests/dromaeo/cssquery-yui.html (next: http://localhost:35890/tests/dromaeo/cssquery-dojo.html) 08:04:31 INFO - PROCESS | 29597 | RSS: Main: 290746368 08:04:31 INFO - PROCESS | 29597 | 08:04:31 INFO - PROCESS | 29597 | __start_tp_report 08:04:31 INFO - PROCESS | 29597 | _x_x_mozilla_page_load 08:04:31 INFO - PROCESS | 29597 | _x_x_mozilla_page_load_details 08:04:31 INFO - PROCESS | 29597 | |i|pagename|runs| 08:04:31 INFO - PROCESS | 29597 | |0;dojo.html;2664.6269522266884;2675.5050315691587;2710.8237964532304;2717.6195332653424;2722.210558937908;4630.398048253723;4688.765561721917;4745.264484004976;4844.563989240967;4883.5116488351105;4779.307000484928;4784.521547845223;4833.178359678855;4840.346553215315;4847.515248475151;4381.649468042565;4404.14119246747;4450.799714012861;4508.887277818048;4574.6340292776495;4482.327650852382;4536.455625324966;4550.863474095782;4564.2240819060835;4581.060882519076;4333.804978775931;4359.694821362475;4411.448568928884;4475.060237350161;4492.056668099703;4407.162639098593;4408.096340250241;4414.028913638995;4536.977315113403;4548.749818759967;4458.487273963503;4460.30865215892;4462.799174037176;4489.932651010237;4495.168393847149;4734.2425211966265;4829.6860704054125;4866.683665561763;4871.610271178297;4910.779014944336;5157.974210128963;5256.342957130359;5295.205719142121;5316.4683531646915;5317.9468205317835;5291.126964050927;5305.549028332596;5318.361796584396;5320.494553017457;5355.651882627656;4700.529947005272;4813.638977076664;4849.951500485021;4975.800967961313;4980.2778597103215;5343.145096784496;5353.892922141536;5397.676139431646;5408.513233808976;5419.105847535191;5128.230765385148;5154.381474223117;5191.169412893919;5202.375714914235;5204.765785539584;4966.081274964144;5150.97424512875;5183.2743415921805;5227.085260079547;5289.629725919226;5187.144121219956;5194.6104042196985;5197.58419326453;5237.3453318335205;5241.528262456321;5169.71566563835;5175.585953123741;5177.870553236199;5184.300119483897;5231.8168864089575;4307.612314891675;4352.1513304905875;4433.866983990485;4465.866024019285;4467;3908.863189788344;3921.705872059607;3937.5668676445566;3997.120633460634;4021.356582946773;4473.955260447419;4475.7985890635;4478.373027776114;4490.39379683745;4530.048689775184;5067.87330316745;5135.050015747024;5289.47105289468;5322.4411436799355;5327.547158491494;4365.192439398721;4369.4101296325225;4417.293233082692;4427.048184640318;4459.241928872099;4691.390119284471;4700.177468942921;4704.694194877322;4712.976435117803;4756.381670382828;4718.245080787057;4884.462709101996;4892.8532144035735;4902.852914412573;4944.134776414185;5174.948250517597;5200.5059519345605;5206.297149884717;5247.2129180623215;5302.151655735064;4875.1224779540025;4879.56083952446;4883.706977581356;4885.5358740919555;4929.580985616263;4932.926006109983;5142.948570514397;5147.8713032173;5159.226116082467;5163;5143.485651434976;5202.765875535534;5211.817586384458;5213.165893457029;5269.973650131725;5032.3961124665275;5043.092243396077;5049.671771334998;5049.7727602257255;5092.363454568179;4915.336429581961;5024.748762561784;5026.874328141826;5064.113780088396;5077.492250775041;4907.582855457326;4955.925661115014;4966.478519755374;4988.6757360771435;5024.020316038337;5093.592512598909;5100.591952643854;5103.846884593319;5104.438511763628;5143.5113664201845;4735.83424580138;4990.6506544541535;4996.15065438869;4999.900002000012;5004.499550045112 08:04:31 INFO - PROCESS | 29597 | |1;ext.html;562.4740867289084;565.2651552981124;570.8715539003723;572.888286784077;579.3829571506348;28593.714062859366;38226.617733822655;39561;39600.80199599005;44064.77967610166;40865.38701919466;41299.79350103245;41375.793121034425;41381.58618413815;41421.58578414215;7332.853342933138;7714.190010048934;7851.057873055212;7857.960710196441;7864.213578642119;7303.744368947088;7524.172341042481;7529.548227106364;10080;10350.896491035068;10068.496575171248;10126.443045632488;10136.746581335452;10138.949305253464;10140.087392134707;9973.052560006789;10029.398236105857;10030.247731420173;10048.849267260997;10049.69850904474;9844.90155098447;9906.40561566301;9906.90093099067;9917.702468925943;9918.3057185997;38128.80935595332;38233.61766382329;38331.61668383308;38447.615523844965;38468;3044.58898048765;3123.7813353065294;3134.5925029745986;3280.442324804765;3639.290338384016;29170.562441563394;29529;29876.55185172224;30136.84931575328;30578.84710576455;3458.394780913355;3498.4052711039185;3509.2279698466295;3539.256756081226;3615.6565126312958;253080;253161;254270.99999999814;256599;257231.71384143145;31810.681893180772;49331.26003109956;49500.50499495031;49518.75240623846;49603.50396496061;32385.676143238736;33773.83113084468;33890.830545847115;33997.32005359879;34038.319233615686;11408.828867566994;11664.125190610568;11714.355710436008;11732.941335293439;11745;9093.909060909305;9293.814123717488;9299.628014879328;9302.953485232665;9305.162535371848;7348.448866334939;7614.124375696755;7889.842203155905;7963.362930965509;8064.314533264738;3037.39252149571;3077.0153251152883;3084.583581216552;3110.6578276389578;3151.2594540283017;787.338635546144;793.4564823096198;891.9554022298859;900.9189172974333;928.6749637626776;28437.715622843505;28549.71450285512;28743.425131497253;29126.708732912823;29188.708112918597;925.1118925831278;959.4051687953374;975.453745902297;1004.864343313658;1054.752133248686;15146.697066058618;15146.924265378602;15309.617259568377;15401.922990384975;15560.766588501181;403720;407667;408924;409174;409642;50354.24468632974;50676.49323506718;50777.74611126921;50812.74593627008;50952.23571646428;1039.2205845615788;1142.8857114288671;1161.9709507262387;1164.871864094949;1187.928724276546;28483.857580711963;30094.849525753107;30498.237544061576;30612.846935765177;30769.69230307668;43181.56818431775;43756.12487750291;43801.56198438102;43911.34132987944;43949.340759889266;318818;318949;318969;320685;321178;25212.873935630938;25991.48017039611;26618.866905666124;26661.466770664865;27595.724042759317;41991.75103112111;42186.7890660557;42514;42735;43554.78222608867;35412.291754165286;35870.282594347445;36021.63978360183;36527.98192198909;36836.447453287685;36009.279814404086;36450.453243201904;36578.26843463169;37305.44041839429;37419;35781.82109089438;35930.28139437249;36288.63711362852;36403.63596364002;36607.45088823723;30535.694643053284;32413;33136;33139.83430082834;33162.33675326432;25382.746172538038;25837.741622583533;25920.740792591834;25921.22236332913;26283.60574591421 08:04:31 INFO - PROCESS | 29597 | |2;jquery.html;345.57666858098816;360.1608252771044;361.1693105856529;362.5106106755878;388.9883303500896;12929.612111636654;16201.675966480678;16395.67208655826;17094.401695940644;17989.550261243476;14531.491397801079;14541.636459088528;14680.779788303184;14705.264736763145;14852.554423367315;5043.218301163316;5266.947330526684;5267.1309233976535;5576.302962129734;6039.456448919596;6120;6142.262928448592;6153.138560601519;6156.168917196188;6156.3843615638525;5888.205092312547;6065.666388348639;6122.295935967376;6142.170806941051;6147.754089836423;5818.709064546756;5984.760609575612;6008.639481631116;6010.939890601104;6125.846853828668;5165;5225.346831646044;5231.2937753403185;5232.450592687751;5234.293370394986;20365.694514582294;20681.793182068137;20940.79059209419;21030.78969210319;21063.157473701034;1718.6820438218845;1987.831034362081;2082.4793801549613;2329.0800133946996;2405.56699794037;8839.425437346616;9075.863862042008;9146.679866204717;9312;12675.958740026526;1683.1331864090002;1711.3496871188993;1715.4939292908623;1767.2312544043382;1811.2845426056765;66581.66709166471;71531;72025.6398718003;72083.2791672087;73012.26987730108;8597;9225.815483690289;9306.813863722824;10070.878027811403;10208.948955255324;11934.880651193376;11999.380083688764;12067.939660301643;12083.275003499819;12097;6352.555321127476;6373.808785736435;6502.707378167994;6504.38208370204;6651.66741662915;6133.110698948627;6186.536009799283;6340.302566717657;6343.238811342576;6359.459445947146;3403.4384326586332;3544.220271540257;3580.9283814323567;3649.525561676965;3668.1013151777984;1746.991265043692;1769.8761086723805;1818.2181661885252;1841.048488602086;1857.4984754116583;858.3690987124459;870.2646263906988;879.090141703334;892.6563273139888;945.0455040409099;17040.016266371815;17165.141742912805;17850.732239016426;17906.28374865017;18236.45290641283;846.9618867150994;859.6991053131354;865.8528050231475;871.7951281448854;875.1948207648978;7409.666565004588;9969.102780749767;9980.750481238027;10067.412586014685;10126.139278161292;388028;388840;394886;397115;400924;75614.62192689111;76364.61817690876;76955;77279.61360193163;78699.21300786918;871.4379225399582;885.9512726800087;887.2946007923587;892.5715656484793;896.9910300897169;14674.486392976194;15447.691046178788;15977.68044639124;15984.280707367963;16015.199240037718;39282.410763837994;39319.213615726956;39538.209235815695;41531.584684152775;41746;51605.741971289906;55223.72388138194;55259.171112432545;56304.34021788571;58480.70759646175;11360.886391136313;12053.071508558589;12168.08739344535;12194.329311887932;12308.692282693004;12643.114981951176;12753.61739147827;12883.098183127091;12970.351482425653;13566.253856038013;10648.733781655521;10699.304545204537;10725.946370268099;10982.505787239754;11437.08503319749;11050;11273.943630281796;11498.310101393608;11581.478833452345;11852.229605075643;10963.397013164353;11065.944670276596;11213.102951763676;11252.156088293246;11404.258723182966;11642.6507204784;11650.126240532163;11742.765144697229;11860.347680877634;12042.578509752117;6833.282505337067;7189.137303523611;7198.74804381865;7464.514806537558;11123.666290011313 08:04:31 INFO - PROCESS | 29597 | |3;mootools.html;1268.4038501904101;1362.0737898229204;1397.0779285671456;1465.5310300703773;1678.5467923660613;6385.648789316591;7186.209516953131;7435.665395057222;7446.218147094558;7660.578668173248;7477.065366829146;7569.772906812805;7582.355499782511;7582.658780354884;7585.469017168801;2119.6608542633144;2149.924752633658;2150.311900191939;2151.182550630766;2153.8923053847325;2075.2632815350557;2121.278765219825;2125.8405619578516;2132.0299263834995;2139.839512036596;2077.740282464692;2093.288281984125;2104.189886893542;2105.3894370632497;2125.893705314728;2066.3077868913856;2067.5658111796392;2068.4725395024325;2069.699893515447;2071.554615757604;1995.281698588507;2067.059487932987;2067.3074520035807;2067.9689804652944;2071.6478198706254;7226.783196504113;7501.849963000709;7533.35966442853;7625.046869141357;7635.923640763577;4051.756894586334;4177.4569305990335;4245.893852653678;4246.065865509614;4251.6386107180615;2653.548896687568;2763.392053748172;2826.307554649124;2828.3636181859124;2830.4763618730394;899.132337294514;899.8875140607424;915.0346384564282;941.4163218804385;944.5324564340626;9916.702498925044;10116.291859569834;10164.44095574743;10189.032041956076;10197.949010254975;3834.4440056191697;3996.420519024783;4066.3087275163293;4153.771542565128;4154;8765.298776097898;8766.430182038148;8766.736997889946;8776.341774366949;8777.736667899973;4186.539480657125;4187.413762073312;4187.539370669224;4189.204051230317;4189.811458484375;3364.4953257011643;3683.4843121962413;3770.9245815083545;3798.2023775007005;3828.1386687994977;3568.1793187567005;3628.1836586767768;3746.5129533160516;3760.417135344026;3761.8683346082757;1185.2947496239724;1212.5755985405037;1212.6422705301957;1215.7082300247878;1225.993870030662;704.4082970304969;734.7465124532027;786.7128498098267;809.6720828064525;831.6361167685002;4830.855074347775;4881;4905.362302900671;4952.613268284886;5026.246063090565;381.18046200668783;381.88161669882425;387.64336810134745;396.1878149792913;408.4220827529073;3282.538071571073;3382.340443613521;3397.8131202784084;3420.281740834403;3437.6562343765922;8434.704785332484;8645.481271123752;8675.696350627697;8863.379563430499;9254.86117708235;8732.8690069649;8750.518721470253;8754.781130471662;8756.474611523328;8766.693165739169;6493.772717954849;6755.560888542229;6818.556793808387;6824.18109826824;7013.2986701329455;5331.600129990189;5413.079776438094;5500.9174862377895;5560.527355174693;5588.804391846266;8702.91297087021;8767.430117042371;8792.956035219782;8856.64573417056;8926.107389261022;8131.634076466455;8429.620667069874;8442.577871106543;8681.696140635047;8873.689420870238;5931.703414829328;6385.201849768779;6540.640264785292;6692.59844409337;6723.26044135135;7127.8574428512175;7148.320909513588;7195.388391986739;7214.89177662346;7281.781546553612;6462.386073323027;6615.305392933865;6661.3338666132995;6742.898856517058;6755.695993680394;6342.048692695948;6402.263739669997;6467.417932386108;6512.08830763684;6560.737570497126;5938.7231745174995;6047.78832740852;6053.424924632153;6056.57603967718;6058.273007238983;4480.50662972489;4512.345709872116;4515.14212299662;4543.386642803312;4624.28323609841;4383.145286669069;4492.450963738741;4508.639308855218;4582.175208462509;4607.07858428309 08:04:31 INFO - PROCESS | 29597 | |4;prototype.html;290.068878898735;297.39034978294495;297.94082038353656;300.9458297506448;301.74201058095326;4872.4640289568115;4872.683275587085;4889.65772395932;4902.166631672615;4934.728589927553;4855.2959820826045;4877.804887804484;4878.950840646928;4884.145274576944;4885.853424397274;3680.5215322008166;3751.8686845960397;3796.316663000659;3805.46723458716;3849.6709490758108;3825.2158307547024;3827.7129215308823;3831.4827498287655;3832.4897192339063;3840.465292906682;3781.2248489059816;3793.867214647488;3796.354619714655;3803.695704343646;3819.4079917612817;3606.981965090184;3641.289948460051;3736.953652977171;3751.3997760358484;3777.1312598102454;3328.4508056170703;3329.1344250495044;3331.3170799986187;3341.448660970937;3361.294128233074;4664.603508701764;4676.883077923045;4714.363560919266;4716.716996980193;4722.3152642866935;4130.54563997963;4289.849855255083;4336.609705126522;4336.696431249814;4338.82644694215;4986.202207646796;5006.448001119628;5010.949890501085;5016.949830501685;5027.572656324217;3642.562892452896;3655.780653160792;3670.889873303805;3673.761205521659;3681.3189559931498;5095.974520127375;5248.422673505911;5319.574434045306;5340.225667278261;5367.81212657559;3700.685441737429;3706.944395834065;3713.922962340945;3738.140227747633;3749.2314075614436;3776.546814382292;3787.791671458041;3790.298794722985;3792.4311353297226;3802.8478860845257;4293.248681480728;4307.729219880143;4308.827646894089;4311.1808756336195;4331.523532411432;4843.39457567804;4994.300797888299;5039.77321020555;5040.243963405518;5098.2352647103235;1297.2864924291603;1315.1648703073618;1317.5586178630074;1324.43711422645;1327.0047464401698;820.3970081989733;848.9193526614962;854.5641722721457;857.4812238595684;857.8241460500583;4258.957410425918;4346.565343465628;4355.477342718831;4356.499002614676;4376.759278239728;5054.671446356048;5114.64197506171;5157.690538567698;5170.922436163461;5183.792648294101;4389.1660584488845;4399.768064941822;4411.228035093845;4414.646828253732;4435.933460998088;2667.213172114231;2738.507513405199;2764.2951047483166;2769.376890199729;2778.1110044785473;4864;4873.6832105913;4895.877603059881;4901.901961960741;4903.215485522299;5088.974555127201;5252.448492908266;5252.579793616502;5273.894522109536;5289.867753306198;4899.387576552931;4899.534544218293;4940.5544255592995;4946.431160416454;4956;5157.381114266162;5172.63791534604;5199.272101905661;5213.895722085613;5247.2129180623215;4971.353724015855;5082.949170508247;5091.439941606494;5122.590192784643;5137.614678899172;4867.975660121819;4872.14737420957;4876.853694389174;4906.116898958222;4908.7545622719435;3767.9058023549633;3772.2832661794173;3787.6780473660046;3801.695864330902;3813.389857622767;5029.44676085623;5252.737363131904;5262.421133675216;5293.179557168645;5299.33758280215;4971.718665680633;5012.974935125301;5038.974805125951;5044.243363495359;5045.066662667418;5036;5050.191969285043;5050.873728156826;5063.670861393997;5105.92341114891;4849.878753031202;4900.444281909002;4977.651564390458;4981.6014718823135;5002.749862506787;4847.394075740533;4972.204447288416;5039.168537191323;5052.722100284373;5065.56942659878;4761.523847615349;4868.2210846264425;4869.4400143982475;4869.926951095807;4878.756062196947 08:04:31 INFO - PROCESS | 29597 | |5;yui.html;646.8512242184297;656.2256537286004;683.5078743304819;726.7129483853878;780.9140994490607;12149.817752733716;13013.219206847572;13014.93492532536;13023.218606883582;13052.28212448315;13063;13856.376463059161;13882.652933676663;13923.234222117804;13929.094608850442;636.1094467745147;765.4297548326505;773.5706682791063;787.6888628991545;793.1592511937336;776.0532150776072;792.0139426414122;793.654760179321;793.7221972309675;793.8531371696225;832.5337810825927;835.4945258118842;837.2883049408015;837.351052933975;837.6900546797693;665.6139439125344;685.6023506366296;833.7665453672981;834.1325021977136;834.2283387866199;505.9949400505985;506.3872714016045;589.7434615942079;598.9940100599025;601.0503404620689;12262.570810021696;12310.076744244217;12326.75346493065;12342.568010119603;12348.444320005621;11914.46384912681;12778;13154.408051637603;13500.864991350158;13751.449942002308;11549.31399821843;12073.698157546043;12252.632421027383;12480.875191248062;12751;4016.9196616067516;4102.487189101363;4182.581741825824;4224.619784219435;4226.894327641833;64314.67842660757;65820.67089664521;66671.333286667;67194.66402667956;67389.66305168491;9191.448513089235;9322.95338523303;9325.720228393158;9327.626894924262;9832.803343933081;17625.823741762673;17714.557136071442;17784.55538611545;17785.19966601506;17843.643127137646;6824.897626535606;6881.41507971818;6884.759033433806;6972.546784458994;7150.249223831527;3703.2963736890442;3718.4980027695915;3736.3648179809497;3768.736188466781;3785.356489396809;2679.61145633882;2716.8641567921527;2737.178846346128;2741.150243424545;2745.5195340815276;469.9130660827758;472.53691382445396;478.8722558375046;480.7115730561635;481.2444462194391;547.6713971616998;562.1427323331951;576.1165367336538;587.3832475900288;591.795830438498;7475.663595138232;7694.07671079474;7847.960760196277;7856.5678887661725;7954.681812727426;369.0386543055302;393.28814845129835;421.9914404573073;447.25531989238203;459.1757794758417;3824.3746407776584;4488.236999710057;4505.896055466432;4531.524189960072;4587.564181402761;101537;101562.49218753859;102535.4873225644;104079.4796026015;106567.46716266368;89080;89470;93055;93559.53220233855;95218;80288;81711;82616.58691706503;83068.75396869052;84201;8202.671893124209;8616;8738.606762695821;8776;8787.209151176425;32003.519947200344;37273.81363093167;43179.36951316865;44337;44725.77637111924;60028.399716002285;60604.090938635076;64896;67113.66443167948;68506.65746671235;11686.24039437434;11727.413629318671;11744.647660570197;11751.059915206592;12301.44643491027;12975;13242.602721918358;13362.665933351354;13616.114952528054;13920.164790112625;11806.527738890692;12279.079069069678;12372.690682733004;12426.440810163384;12692.365381730691;12678.239305641691;12744.74510509803;12796.232226066466;13074.869251307366;13457.596272111852;12379.62861114168;12454.43955022008;12586.118971671895;13233.691577105723;13344.26606536611;9955.601775928882;9970.950145249228;10703.732406689895;10738.19463540222;10882.510287037261;10513.158947284352;10877.67366978992;10878.564857405616;10895.564177432814;10948.56205751793 08:04:31 INFO - PROCESS | 29597 | __end_tp_report 08:04:31 INFO - PROCESS | 29597 | __start_cc_report 08:04:31 INFO - PROCESS | 29597 | _x_x_mozilla_cycle_collect,1033 08:04:31 INFO - PROCESS | 29597 | __end_cc_report 08:04:31 INFO - PROCESS | 29597 | __startTimestamp1470323071690__endTimestamp 08:04:31 INFO - PROCESS | 29597 | 08:04:31 INFO - PROCESS | 29597 | ------- Summary: start ------- 08:04:31 INFO - PROCESS | 29597 | Number of tests: 6 08:04:31 INFO - PROCESS | 29597 | 08:04:31 INFO - PROCESS | 29597 | [#0] dojo.html Cycles:165 Average:4807.62 Median:4910.78 stddev:509.96 (10.4%) stddev-sans-first:483.02 08:04:31 INFO - PROCESS | 29597 | Values: 2664.6 2675.5 2710.8 2717.6 2722.2 4630.4 4688.8 4745.3 4844.6 4883.5 4779.3 4784.5 4833.2 4840.3 4847.5 4381.6 4404.1 4450.8 4508.9 4574.6 4482.3 4536.5 4550.9 4564.2 4581.1 4333.8 4359.7 4411.4 4475.1 4492.1 4407.2 4408.1 4414.0 4537.0 4548.7 4458.5 4460.3 4462.8 4489.9 4495.2 4734.2 4829.7 4866.7 4871.6 4910.8 5158.0 5256.3 5295.2 5316.5 5317.9 5291.1 5305.5 5318.4 5320.5 5355.7 4700.5 4813.6 4850.0 4975.8 4980.3 5343.1 5353.9 5397.7 5408.5 5419.1 5128.2 5154.4 5191.2 5202.4 5204.8 4966.1 5151.0 5183.3 5227.1 5289.6 5187.1 5194.6 5197.6 5237.3 5241.5 5169.7 5175.6 5177.9 5184.3 5231.8 4307.6 4352.2 4433.9 4465.9 4467.0 3908.9 3921.7 3937.6 3997.1 4021.4 4474.0 4475.8 4478.4 4490.4 4530.0 5067.9 5135.1 5289.5 5322.4 5327.5 4365.2 4369.4 4417.3 4427.0 4459.2 4691.4 4700.2 4704.7 4713.0 4756.4 4718.2 4884.5 4892.9 4902.9 4944.1 5174.9 5200.5 5206.3 5247.2 5302.2 4875.1 4879.6 4883.7 4885.5 4929.6 4932.9 5142.9 5147.9 5159.2 5163.0 5143.5 5202.8 5211.8 5213.2 5270.0 5032.4 5043.1 5049.7 5049.8 5092.4 4915.3 5024.7 5026.9 5064.1 5077.5 4907.6 4955.9 4966.5 4988.7 5024.0 5093.6 5100.6 5103.8 5104.4 5143.5 4735.8 4990.7 4996.2 4999.9 5004.5 08:04:31 INFO - PROCESS | 29597 | 08:04:31 INFO - PROCESS | 29597 | [#1] ext.html Cycles:180 Average:47304.75 Median:35900.28 stddev:87992.95 (245.1%) stddev-sans-first:88169.81 08:04:31 INFO - PROCESS | 29597 | Values: 562.5 565.3 570.9 572.9 579.4 28593.7 38226.6 39561.0 39600.8 44064.8 40865.4 41299.8 41375.8 41381.6 41421.6 7332.9 7714.2 7851.1 7858.0 7864.2 7303.7 7524.2 7529.5 10080.0 10350.9 10068.5 10126.4 10136.7 10138.9 10140.1 9973.1 10029.4 10030.2 10048.8 10049.7 9844.9 9906.4 9906.9 9917.7 9918.3 38128.8 38233.6 38331.6 38447.6 38468.0 3044.6 3123.8 3134.6 3280.4 3639.3 29170.6 29529.0 29876.6 30136.8 30578.8 3458.4 3498.4 3509.2 3539.3 3615.7 253080.0 253161.0 254271.0 256599.0 257231.7 31810.7 49331.3 49500.5 49518.8 49603.5 32385.7 33773.8 33890.8 33997.3 34038.3 11408.8 11664.1 11714.4 11732.9 11745.0 9093.9 9293.8 9299.6 9303.0 9305.2 7348.4 7614.1 7889.8 7963.4 8064.3 3037.4 3077.0 3084.6 3110.7 3151.3 787.3 793.5 892.0 900.9 928.7 28437.7 28549.7 28743.4 29126.7 29188.7 925.1 959.4 975.5 1004.9 1054.8 15146.7 15146.9 15309.6 15401.9 15560.8 403720.0 407667.0 408924.0 409174.0 409642.0 50354.2 50676.5 50777.7 50812.7 50952.2 1039.2 1142.9 1162.0 1164.9 1187.9 28483.9 30094.8 30498.2 30612.8 30769.7 43181.6 43756.1 43801.6 43911.3 43949.3 318818.0 318949.0 318969.0 320685.0 321178.0 25212.9 25991.5 26618.9 26661.5 27595.7 41991.8 42186.8 42514.0 42735.0 43554.8 35412.3 35870.3 36021.6 36528.0 36836.4 36009.3 36450.5 36578.3 37305.4 37419.0 35781.8 35930.3 36288.6 36403.6 36607.5 30535.7 32413.0 33136.0 33139.8 33162.3 25382.7 25837.7 25920.7 25921.2 26283.6 08:04:31 INFO - PROCESS | 29597 | 08:04:31 INFO - PROCESS | 29597 | [#2] jquery.html Cycles:180 Average:24873.38 Median:194208.49 stddev:65093.34 (33.5%) stddev-sans-first:65249.89 08:04:31 INFO - PROCESS | 29597 | Values: 345.6 360.2 361.2 362.5 389.0 12929.6 16201.7 16395.7 17094.4 17989.6 14531.5 14541.6 14680.8 14705.3 14852.6 5043.2 5266.9 5267.1 5576.3 6039.5 6120.0 6142.3 6153.1 6156.2 6156.4 5888.2 6065.7 6122.3 6142.2 6147.8 5818.7 5984.8 6008.6 6010.9 6125.8 5165.0 5225.3 5231.3 5232.5 5234.3 20365.7 20681.8 20940.8 21030.8 21063.2 1718.7 1987.8 2082.5 2329.1 2405.6 8839.4 9075.9 9146.7 9312.0 12676.0 1683.1 1711.3 1715.5 1767.2 1811.3 66581.7 71531.0 72025.6 72083.3 73012.3 8597.0 9225.8 9306.8 10070.9 10208.9 11934.9 11999.4 12067.9 12083.3 12097.0 6352.6 6373.8 6502.7 6504.4 6651.7 6133.1 6186.5 6340.3 6343.2 6359.5 3403.4 3544.2 3580.9 3649.5 3668.1 1747.0 1769.9 1818.2 1841.0 1857.5 858.4 870.3 879.1 892.7 945.0 17040.0 17165.1 17850.7 17906.3 18236.5 847.0 859.7 865.9 871.8 875.2 7409.7 9969.1 9980.8 10067.4 10126.1 388028.0 388840.0 394886.0 397115.0 400924.0 75614.6 76364.6 76955.0 77279.6 78699.2 871.4 886.0 887.3 892.6 897.0 14674.5 15447.7 15977.7 15984.3 16015.2 39282.4 39319.2 39538.2 41531.6 41746.0 51605.7 55223.7 55259.2 56304.3 58480.7 11360.9 12053.1 12168.1 12194.3 12308.7 12643.1 12753.6 12883.1 12970.4 13566.3 10648.7 10699.3 10725.9 10982.5 11437.1 11050.0 11273.9 11498.3 11581.5 11852.2 10963.4 11065.9 11213.1 11252.2 11404.3 11642.7 11650.1 11742.8 11860.3 12042.6 6833.3 7189.1 7198.7 7464.5 11123.7 08:04:31 INFO - PROCESS | 29597 | 08:04:31 INFO - PROCESS | 29597 | [#3] mootools.html Cycles:180 Average:4895.07 Median:4893.18 stddev:2738.07 (56.0%) stddev-sans-first:2732.18 08:04:31 INFO - PROCESS | 29597 | Values: 1268.4 1362.1 1397.1 1465.5 1678.5 6385.6 7186.2 7435.7 7446.2 7660.6 7477.1 7569.8 7582.4 7582.7 7585.5 2119.7 2149.9 2150.3 2151.2 2153.9 2075.3 2121.3 2125.8 2132.0 2139.8 2077.7 2093.3 2104.2 2105.4 2125.9 2066.3 2067.6 2068.5 2069.7 2071.6 1995.3 2067.1 2067.3 2068.0 2071.6 7226.8 7501.8 7533.4 7625.0 7635.9 4051.8 4177.5 4245.9 4246.1 4251.6 2653.5 2763.4 2826.3 2828.4 2830.5 899.1 899.9 915.0 941.4 944.5 9916.7 10116.3 10164.4 10189.0 10197.9 3834.4 3996.4 4066.3 4153.8 4154.0 8765.3 8766.4 8766.7 8776.3 8777.7 4186.5 4187.4 4187.5 4189.2 4189.8 3364.5 3683.5 3770.9 3798.2 3828.1 3568.2 3628.2 3746.5 3760.4 3761.9 1185.3 1212.6 1212.6 1215.7 1226.0 704.4 734.7 786.7 809.7 831.6 4830.9 4881.0 4905.4 4952.6 5026.2 381.2 381.9 387.6 396.2 408.4 3282.5 3382.3 3397.8 3420.3 3437.7 8434.7 8645.5 8675.7 8863.4 9254.9 8732.9 8750.5 8754.8 8756.5 8766.7 6493.8 6755.6 6818.6 6824.2 7013.3 5331.6 5413.1 5500.9 5560.5 5588.8 8702.9 8767.4 8793.0 8856.6 8926.1 8131.6 8429.6 8442.6 8681.7 8873.7 5931.7 6385.2 6540.6 6692.6 6723.3 7127.9 7148.3 7195.4 7214.9 7281.8 6462.4 6615.3 6661.3 6742.9 6755.7 6342.0 6402.3 6467.4 6512.1 6560.7 5938.7 6047.8 6053.4 6056.6 6058.3 4480.5 4512.3 4515.1 4543.4 4624.3 4383.1 4492.5 4508.6 4582.2 4607.1 08:04:31 INFO - PROCESS | 29597 | 08:04:31 INFO - PROCESS | 29597 | [#4] prototype.html Cycles:180 Average:4199.17 Median:4865.99 stddev:1208.56 (24.8%) stddev-sans-first:1175.79 08:04:31 INFO - PROCESS | 29597 | Values: 290.1 297.4 297.9 300.9 301.7 4872.5 4872.7 4889.7 4902.2 4934.7 4855.3 4877.8 4879.0 4884.1 4885.9 3680.5 3751.9 3796.3 3805.5 3849.7 3825.2 3827.7 3831.5 3832.5 3840.5 3781.2 3793.9 3796.4 3803.7 3819.4 3607.0 3641.3 3737.0 3751.4 3777.1 3328.5 3329.1 3331.3 3341.4 3361.3 4664.6 4676.9 4714.4 4716.7 4722.3 4130.5 4289.8 4336.6 4336.7 4338.8 4986.2 5006.4 5010.9 5016.9 5027.6 3642.6 3655.8 3670.9 3673.8 3681.3 5096.0 5248.4 5319.6 5340.2 5367.8 3700.7 3706.9 3713.9 3738.1 3749.2 3776.5 3787.8 3790.3 3792.4 3802.8 4293.2 4307.7 4308.8 4311.2 4331.5 4843.4 4994.3 5039.8 5040.2 5098.2 1297.3 1315.2 1317.6 1324.4 1327.0 820.4 848.9 854.6 857.5 857.8 4259.0 4346.6 4355.5 4356.5 4376.8 5054.7 5114.6 5157.7 5170.9 5183.8 4389.2 4399.8 4411.2 4414.6 4435.9 2667.2 2738.5 2764.3 2769.4 2778.1 4864.0 4873.7 4895.9 4901.9 4903.2 5089.0 5252.4 5252.6 5273.9 5289.9 4899.4 4899.5 4940.6 4946.4 4956.0 5157.4 5172.6 5199.3 5213.9 5247.2 4971.4 5082.9 5091.4 5122.6 5137.6 4868.0 4872.1 4876.9 4906.1 4908.8 3767.9 3772.3 3787.7 3801.7 3813.4 5029.4 5252.7 5262.4 5293.2 5299.3 4971.7 5013.0 5039.0 5044.2 5045.1 5036.0 5050.2 5050.9 5063.7 5105.9 4849.9 4900.4 4977.7 4981.6 5002.7 4847.4 4972.2 5039.2 5052.7 5065.6 4761.5 4868.2 4869.4 4869.9 4878.8 08:04:31 INFO - PROCESS | 29597 | 08:04:31 INFO - PROCESS | 29597 | [#5] yui.html Cycles:180 Average:18573.05 Median:22392.13 stddev:27054.02 (120.8%) stddev-sans-first:27096.43 08:04:31 INFO - PROCESS | 29597 | Values: 646.9 656.2 683.5 726.7 780.9 12149.8 13013.2 13014.9 13023.2 13052.3 13063.0 13856.4 13882.7 13923.2 13929.1 636.1 765.4 773.6 787.7 793.2 776.1 792.0 793.7 793.7 793.9 832.5 835.5 837.3 837.4 837.7 665.6 685.6 833.8 834.1 834.2 506.0 506.4 589.7 599.0 601.1 12262.6 12310.1 12326.8 12342.6 12348.4 11914.5 12778.0 13154.4 13500.9 13751.4 11549.3 12073.7 12252.6 12480.9 12751.0 4016.9 4102.5 4182.6 4224.6 4226.9 64314.7 65820.7 66671.3 67194.7 67389.7 9191.4 9323.0 9325.7 9327.6 9832.8 17625.8 17714.6 17784.6 17785.2 17843.6 6824.9 6881.4 6884.8 6972.5 7150.2 3703.3 3718.5 3736.4 3768.7 3785.4 2679.6 2716.9 2737.2 2741.2 2745.5 469.9 472.5 478.9 480.7 481.2 547.7 562.1 576.1 587.4 591.8 7475.7 7694.1 7848.0 7856.6 7954.7 369.0 393.3 422.0 447.3 459.2 3824.4 4488.2 4505.9 4531.5 4587.6 101537.0 101562.5 102535.5 104079.5 106567.5 89080.0 89470.0 93055.0 93559.5 95218.0 80288.0 81711.0 82616.6 83068.8 84201.0 8202.7 8616.0 8738.6 8776.0 8787.2 32003.5 37273.8 43179.4 44337.0 44725.8 60028.4 60604.1 64896.0 67113.7 68506.7 11686.2 11727.4 11744.6 11751.1 12301.4 12975.0 13242.6 13362.7 13616.1 13920.2 11806.5 12279.1 12372.7 12426.4 12692.4 12678.2 12744.7 12796.2 13074.9 13457.6 12379.6 12454.4 12586.1 13233.7 13344.3 9955.6 9971.0 10703.7 10738.2 10882.5 10513.2 10877.7 10878.6 10895.6 10948.6 08:04:31 INFO - PROCESS | 29597 | -------- Summary: end -------- 08:04:31 INFO - PROCESS | 29597 | 08:04:32 INFO - TEST-INFO | 29597: exit 0 08:04:32 INFO - TEST-OK | dromaeo_css | took 1120787ms 08:04:32 INFO - TEST-START | kraken 08:04:32 INFO - operating with platform_type : linux_ 08:04:32 INFO - Initialising browser for kraken test... 08:04:32 INFO - TEST-INFO | started process 29784 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJVd_la/profile http://localhost:35890/getInfo.html) 08:04:36 INFO - PROCESS | 29784 | __metrics Screen width/height:1600/1200 08:04:36 INFO - PROCESS | 29784 | colorDepth:24 08:04:36 INFO - PROCESS | 29784 | Browser inner width/height: 1024/697 08:04:36 INFO - PROCESS | 29784 | __metrics 08:04:37 INFO - PROCESS | 29784 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:04:37 INFO - PROCESS | 29784 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:04:37 INFO - PROCESS | 29784 | console.error: PushService: 08:04:37 INFO - PROCESS | 29784 | stateChangeProcessEnqueue: Error transitioning state 08:04:37 INFO - PROCESS | 29784 | UnknownError 08:04:38 INFO - TEST-INFO | 29784: exit 0 08:04:38 INFO - Browser initialized. 08:04:38 INFO - Running cycle 1/1 for kraken test... 08:04:38 INFO - TEST-INFO | started process 29864 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJVd_la/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:04:50 INFO - PROCESS | 29864 | RSS: Main: 157831168 08:04:50 INFO - PROCESS | 29864 | 08:04:53 INFO - PROCESS | 29864 | Cycle 1(1): loaded http://localhost:35890/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35890/tests/kraken/driver.html?testName=audio-beat-detection) 08:04:54 INFO - PROCESS | 29864 | RSS: Main: 214179840 08:04:54 INFO - PROCESS | 29864 | 08:04:56 INFO - PROCESS | 29864 | Cycle 1(1): loaded http://localhost:35890/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35890/tests/kraken/driver.html?testName=audio-dft) 08:04:57 INFO - PROCESS | 29864 | RSS: Main: 191217664 08:04:57 INFO - PROCESS | 29864 | 08:05:00 INFO - PROCESS | 29864 | Cycle 1(1): loaded http://localhost:35890/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35890/tests/kraken/driver.html?testName=audio-fft) 08:05:01 INFO - PROCESS | 29864 | RSS: Main: 270630912 08:05:01 INFO - PROCESS | 29864 | 08:05:03 INFO - PROCESS | 29864 | Cycle 1(1): loaded http://localhost:35890/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35890/tests/kraken/driver.html?testName=audio-oscillator) 08:05:04 INFO - PROCESS | 29864 | RSS: Main: 180637696 08:05:04 INFO - PROCESS | 29864 | 08:05:06 INFO - PROCESS | 29864 | Cycle 1(1): loaded http://localhost:35890/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35890/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:05:06 INFO - PROCESS | 29864 | RSS: Main: 185057280 08:05:06 INFO - PROCESS | 29864 | 08:05:10 INFO - PROCESS | 29864 | Cycle 1(1): loaded http://localhost:35890/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35890/tests/kraken/driver.html?testName=imaging-darkroom) 08:05:10 INFO - PROCESS | 29864 | RSS: Main: 221622272 08:05:10 INFO - PROCESS | 29864 | 08:05:14 INFO - PROCESS | 29864 | Cycle 1(1): loaded http://localhost:35890/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35890/tests/kraken/driver.html?testName=imaging-desaturate) 08:05:14 INFO - PROCESS | 29864 | RSS: Main: 215334912 08:05:14 INFO - PROCESS | 29864 | 08:05:17 INFO - PROCESS | 29864 | Cycle 1(1): loaded http://localhost:35890/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35890/tests/kraken/driver.html?testName=json-parse-financial) 08:05:18 INFO - PROCESS | 29864 | RSS: Main: 218955776 08:05:18 INFO - PROCESS | 29864 | 08:05:20 INFO - PROCESS | 29864 | Cycle 1(1): loaded http://localhost:35890/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35890/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:05:20 INFO - PROCESS | 29864 | RSS: Main: 184885248 08:05:20 INFO - PROCESS | 29864 | 08:05:22 INFO - PROCESS | 29864 | Cycle 1(1): loaded http://localhost:35890/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35890/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:05:23 INFO - PROCESS | 29864 | RSS: Main: 189587456 08:05:23 INFO - PROCESS | 29864 | 08:05:25 INFO - PROCESS | 29864 | Cycle 1(1): loaded http://localhost:35890/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35890/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:05:26 INFO - PROCESS | 29864 | RSS: Main: 193855488 08:05:26 INFO - PROCESS | 29864 | 08:05:28 INFO - PROCESS | 29864 | Cycle 1(1): loaded http://localhost:35890/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35890/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:05:29 INFO - PROCESS | 29864 | RSS: Main: 189194240 08:05:29 INFO - PROCESS | 29864 | 08:05:32 INFO - PROCESS | 29864 | Cycle 1(1): loaded http://localhost:35890/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35890/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:05:33 INFO - PROCESS | 29864 | RSS: Main: 192851968 08:05:33 INFO - PROCESS | 29864 | 08:05:34 INFO - PROCESS | 29864 | Cycle 1(1): loaded http://localhost:35890/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35890/tests/kraken/driver.html?testName=ai-astar) 08:05:35 INFO - PROCESS | 29864 | RSS: Main: 243499008 08:05:35 INFO - PROCESS | 29864 | 08:05:35 INFO - PROCESS | 29864 | __start_tp_report 08:05:35 INFO - PROCESS | 29864 | _x_x_mozilla_page_load 08:05:35 INFO - PROCESS | 29864 | _x_x_mozilla_page_load_details 08:05:35 INFO - PROCESS | 29864 | |i|pagename|runs| 08:05:35 INFO - PROCESS | 29864 | |0;ai-astar;105;115;114;115;113;113;114;114;113;113 08:05:35 INFO - PROCESS | 29864 | |1;audio-beat-detection;147;122;122;185;124;123;158;123;189;129 08:05:35 INFO - PROCESS | 29864 | |2;audio-dft;160;163;161;162;162;160;160;162;161;160 08:05:35 INFO - PROCESS | 29864 | |3;audio-fft;75;75;75;117;76;77;77;76;105;75 08:05:35 INFO - PROCESS | 29864 | |4;audio-oscillator;84;86;114;84;85;85;118;84;85;124 08:05:35 INFO - PROCESS | 29864 | |5;imaging-gaussian-blur;117;117;116;117;116;117;117;116;117;117 08:05:35 INFO - PROCESS | 29864 | |6;imaging-darkroom;146;146;147;148;146;147;146;146;146;146 08:05:35 INFO - PROCESS | 29864 | |7;imaging-desaturate;94;95;94;95;95;96;96;95;95;95 08:05:35 INFO - PROCESS | 29864 | |8;json-parse-financial;65;64;62;63;64;68;71;62;62;64 08:05:35 INFO - PROCESS | 29864 | |9;json-stringify-tinderbox;64;65;65;64;65;65;65;64;67;65 08:05:35 INFO - PROCESS | 29864 | |10;stanford-crypto-aes;85;80;79;80;81;80;78;79;80;84 08:05:35 INFO - PROCESS | 29864 | |11;stanford-crypto-ccm;135;140;139;144;128;139;129;131;186;141 08:05:35 INFO - PROCESS | 29864 | |12;stanford-crypto-pbkdf2;169;173;173;165;173;170;166;167;168;166 08:05:35 INFO - PROCESS | 29864 | |13;stanford-crypto-sha256-iterative;71;68;67;68;67;67;67;67;66;66 08:05:35 INFO - PROCESS | 29864 | __end_tp_report 08:05:35 INFO - PROCESS | 29864 | __start_cc_report 08:05:35 INFO - PROCESS | 29864 | _x_x_mozilla_cycle_collect,1939 08:05:35 INFO - PROCESS | 29864 | __end_cc_report 08:05:35 INFO - PROCESS | 29864 | __startTimestamp1470323135008__endTimestamp 08:05:35 INFO - PROCESS | 29864 | 08:05:35 INFO - PROCESS | 29864 | ------- Summary: start ------- 08:05:35 INFO - PROCESS | 29864 | Number of tests: 14 08:05:35 INFO - PROCESS | 29864 | 08:05:35 INFO - PROCESS | 29864 | [#0] ai-astar Cycles:10 Average:112.90 Median:114.00 stddev:2.88 (2.5%) stddev-sans-first:0.83 08:05:35 INFO - PROCESS | 29864 | Values: 105.0 115.0 114.0 115.0 113.0 113.0 114.0 114.0 113.0 113.0 08:05:35 INFO - PROCESS | 29864 | 08:05:35 INFO - PROCESS | 29864 | [#1] audio-beat-detection Cycles:10 Average:142.20 Median:138.00 stddev:26.57 (19.3%) stddev-sans-first:28.12 08:05:35 INFO - PROCESS | 29864 | Values: 147.0 122.0 122.0 185.0 124.0 123.0 158.0 123.0 189.0 129.0 08:05:35 INFO - PROCESS | 29864 | 08:05:35 INFO - PROCESS | 29864 | [#2] audio-dft Cycles:10 Average:161.10 Median:161.50 stddev:1.10 (0.7%) stddev-sans-first:1.09 08:05:35 INFO - PROCESS | 29864 | Values: 160.0 163.0 161.0 162.0 162.0 160.0 160.0 162.0 161.0 160.0 08:05:35 INFO - PROCESS | 29864 | 08:05:35 INFO - PROCESS | 29864 | [#3] audio-fft Cycles:10 Average:82.80 Median:75.50 stddev:15.15 (20.1%) stddev-sans-first:15.80 08:05:35 INFO - PROCESS | 29864 | Values: 75.0 75.0 75.0 117.0 76.0 77.0 77.0 76.0 105.0 75.0 08:05:35 INFO - PROCESS | 29864 | 08:05:35 INFO - PROCESS | 29864 | [#4] audio-oscillator Cycles:10 Average:94.90 Median:84.50 stddev:16.58 (19.6%) stddev-sans-first:17.11 08:05:35 INFO - PROCESS | 29864 | Values: 84.0 86.0 114.0 84.0 85.0 85.0 118.0 84.0 85.0 124.0 08:05:35 INFO - PROCESS | 29864 | 08:05:35 INFO - PROCESS | 29864 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 08:05:35 INFO - PROCESS | 29864 | Values: 117.0 117.0 116.0 117.0 116.0 117.0 117.0 116.0 117.0 117.0 08:05:35 INFO - PROCESS | 29864 | 08:05:35 INFO - PROCESS | 29864 | [#6] imaging-darkroom Cycles:10 Average:146.40 Median:146.00 stddev:0.70 (0.5%) stddev-sans-first:0.73 08:05:35 INFO - PROCESS | 29864 | Values: 146.0 146.0 147.0 148.0 146.0 147.0 146.0 146.0 146.0 146.0 08:05:35 INFO - PROCESS | 29864 | 08:05:35 INFO - PROCESS | 29864 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.67 (0.7%) stddev-sans-first:0.60 08:05:35 INFO - PROCESS | 29864 | Values: 94.0 95.0 94.0 95.0 95.0 96.0 96.0 95.0 95.0 95.0 08:05:35 INFO - PROCESS | 29864 | 08:05:35 INFO - PROCESS | 29864 | [#8] json-parse-financial Cycles:10 Average:64.50 Median:64.00 stddev:2.92 (4.6%) stddev-sans-first:3.09 08:05:35 INFO - PROCESS | 29864 | Values: 65.0 64.0 62.0 63.0 64.0 68.0 71.0 62.0 62.0 64.0 08:05:35 INFO - PROCESS | 29864 | 08:05:35 INFO - PROCESS | 29864 | [#9] json-stringify-tinderbox Cycles:10 Average:64.90 Median:65.00 stddev:0.88 (1.3%) stddev-sans-first:0.87 08:05:35 INFO - PROCESS | 29864 | Values: 64.0 65.0 65.0 64.0 65.0 65.0 65.0 64.0 67.0 65.0 08:05:35 INFO - PROCESS | 29864 | 08:05:35 INFO - PROCESS | 29864 | [#10] stanford-crypto-aes Cycles:10 Average:80.60 Median:80.00 stddev:2.22 (2.8%) stddev-sans-first:1.69 08:05:35 INFO - PROCESS | 29864 | Values: 85.0 80.0 79.0 80.0 81.0 80.0 78.0 79.0 80.0 84.0 08:05:35 INFO - PROCESS | 29864 | 08:05:35 INFO - PROCESS | 29864 | [#11] stanford-crypto-ccm Cycles:10 Average:141.20 Median:139.50 stddev:16.64 (11.9%) stddev-sans-first:17.50 08:05:35 INFO - PROCESS | 29864 | Values: 135.0 140.0 139.0 144.0 128.0 139.0 129.0 131.0 186.0 141.0 08:05:35 INFO - PROCESS | 29864 | 08:05:35 INFO - PROCESS | 29864 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.00 Median:169.50 stddev:3.13 (1.8%) stddev-sans-first:3.32 08:05:35 INFO - PROCESS | 29864 | Values: 169.0 173.0 173.0 165.0 173.0 170.0 166.0 167.0 168.0 166.0 08:05:35 INFO - PROCESS | 29864 | 08:05:35 INFO - PROCESS | 29864 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.40 Median:67.00 stddev:1.43 (2.1%) stddev-sans-first:0.71 08:05:35 INFO - PROCESS | 29864 | Values: 71.0 68.0 67.0 68.0 67.0 67.0 67.0 67.0 66.0 66.0 08:05:35 INFO - PROCESS | 29864 | -------- Summary: end -------- 08:05:35 INFO - PROCESS | 29864 | 08:05:35 INFO - TEST-INFO | 29864: exit 0 08:05:36 INFO - TEST-OK | kraken | took 63475ms 08:05:36 INFO - SUITE-END | took 1184s 08:05:36 INFO - Completed test suite (00:19:44) 08:05:36 INFO - javascript benchmark 08:05:36 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2664.6269522266884, 2675.5050315691587, 2710.8237964532304, 2717.6195332653424, 2722.210558937908, 4630.398048253723, 4688.765561721917, 4745.264484004976, 4844.563989240967, 4883.5116488351105, 4779.307000484928, 4784.521547845223, 4833.178359678855, 4840.346553215315, 4847.515248475151, 4381.649468042565, 4404.14119246747, 4450.799714012861, 4508.887277818048, 4574.6340292776495, 4482.327650852382, 4536.455625324966, 4550.863474095782, 4564.2240819060835, 4581.060882519076, 4333.804978775931, 4359.694821362475, 4411.448568928884, 4475.060237350161, 4492.056668099703, 4407.162639098593, 4408.096340250241, 4414.028913638995, 4536.977315113403, 4548.749818759967, 4458.487273963503, 4460.30865215892, 4462.799174037176, 4489.932651010237, 4495.168393847149, 4734.2425211966265, 4829.6860704054125, 4866.683665561763, 4871.610271178297, 4910.779014944336, 5157.974210128963, 5256.342957130359, 5295.205719142121, 5316.4683531646915, 5317.9468205317835, 5291.126964050927, 5305.549028332596, 5318.361796584396, 5320.494553017457, 5355.651882627656, 4700.529947005272, 4813.638977076664, 4849.951500485021, 4975.800967961313, 4980.2778597103215, 5343.145096784496, 5353.892922141536, 5397.676139431646, 5408.513233808976, 5419.105847535191, 5128.230765385148, 5154.381474223117, 5191.169412893919, 5202.375714914235, 5204.765785539584, 4966.081274964144, 5150.97424512875, 5183.2743415921805, 5227.085260079547, 5289.629725919226, 5187.144121219956, 5194.6104042196985, 5197.58419326453, 5237.3453318335205, 5241.528262456321, 5169.71566563835, 5175.585953123741, 5177.870553236199, 5184.300119483897, 5231.8168864089575, 4307.612314891675, 4352.1513304905875, 4433.866983990485, 4465.866024019285, 4467.0, 3908.863189788344, 3921.705872059607, 3937.5668676445566, 3997.120633460634, 4021.356582946773, 4473.955260447419, 4475.7985890635, 4478.373027776114, 4490.39379683745, 4530.048689775184, 5067.87330316745, 5135.050015747024, 5289.47105289468, 5322.4411436799355, 5327.547158491494, 4365.192439398721, 4369.4101296325225, 4417.293233082692, 4427.048184640318, 4459.241928872099, 4691.390119284471, 4700.177468942921, 4704.694194877322, 4712.976435117803, 4756.381670382828, 4718.245080787057, 4884.462709101996, 4892.8532144035735, 4902.852914412573, 4944.134776414185, 5174.948250517597, 5200.5059519345605, 5206.297149884717, 5247.2129180623215, 5302.151655735064, 4875.1224779540025, 4879.56083952446, 4883.706977581356, 4885.5358740919555, 4929.580985616263, 4932.926006109983, 5142.948570514397, 5147.8713032173, 5159.226116082467, 5163.0, 5143.485651434976, 5202.765875535534, 5211.817586384458, 5213.165893457029, 5269.973650131725, 5032.3961124665275, 5043.092243396077, 5049.671771334998, 5049.7727602257255, 5092.363454568179, 4915.336429581961, 5024.748762561784, 5026.874328141826, 5064.113780088396, 5077.492250775041, 4907.582855457326, 4955.925661115014, 4966.478519755374, 4988.6757360771435, 5024.020316038337, 5093.592512598909, 5100.591952643854, 5103.846884593319, 5104.438511763628, 5143.5113664201845, 4735.83424580138, 4990.6506544541535, 4996.15065438869, 4999.900002000012, 5004.499550045112], "value": 4774.910042222575, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [562.4740867289084, 565.2651552981124, 570.8715539003723, 572.888286784077, 579.3829571506348, 28593.714062859366, 38226.617733822655, 39561.0, 39600.80199599005, 44064.77967610166, 40865.38701919466, 41299.79350103245, 41375.793121034425, 41381.58618413815, 41421.58578414215, 7332.853342933138, 7714.190010048934, 7851.057873055212, 7857.960710196441, 7864.213578642119, 7303.744368947088, 7524.172341042481, 7529.548227106364, 10080.0, 10350.896491035068, 10068.496575171248, 10126.443045632488, 10136.746581335452, 10138.949305253464, 10140.087392134707, 9973.052560006789, 10029.398236105857, 10030.247731420173, 10048.849267260997, 10049.69850904474, 9844.90155098447, 9906.40561566301, 9906.90093099067, 9917.702468925943, 9918.3057185997, 38128.80935595332, 38233.61766382329, 38331.61668383308, 38447.615523844965, 38468.0, 3044.58898048765, 3123.7813353065294, 3134.5925029745986, 3280.442324804765, 3639.290338384016, 29170.562441563394, 29529.0, 29876.55185172224, 30136.84931575328, 30578.84710576455, 3458.394780913355, 3498.4052711039185, 3509.2279698466295, 3539.256756081226, 3615.6565126312958, 253080.0, 253161.0, 254270.99999999814, 256599.0, 257231.71384143145, 31810.681893180772, 49331.26003109956, 49500.50499495031, 49518.75240623846, 49603.50396496061, 32385.676143238736, 33773.83113084468, 33890.830545847115, 33997.32005359879, 34038.319233615686, 11408.828867566994, 11664.125190610568, 11714.355710436008, 11732.941335293439, 11745.0, 9093.909060909305, 9293.814123717488, 9299.628014879328, 9302.953485232665, 9305.162535371848, 7348.448866334939, 7614.124375696755, 7889.842203155905, 7963.362930965509, 8064.314533264738, 3037.39252149571, 3077.0153251152883, 3084.583581216552, 3110.6578276389578, 3151.2594540283017, 787.338635546144, 793.4564823096198, 891.9554022298859, 900.9189172974333, 928.6749637626776, 28437.715622843505, 28549.71450285512, 28743.425131497253, 29126.708732912823, 29188.708112918597, 925.1118925831278, 959.4051687953374, 975.453745902297, 1004.864343313658, 1054.752133248686, 15146.697066058618, 15146.924265378602, 15309.617259568377, 15401.922990384975, 15560.766588501181, 403720.0, 407667.0, 408924.0, 409174.0, 409642.0, 50354.24468632974, 50676.49323506718, 50777.74611126921, 50812.74593627008, 50952.23571646428, 1039.2205845615788, 1142.8857114288671, 1161.9709507262387, 1164.871864094949, 1187.928724276546, 28483.857580711963, 30094.849525753107, 30498.237544061576, 30612.846935765177, 30769.69230307668, 43181.56818431775, 43756.12487750291, 43801.56198438102, 43911.34132987944, 43949.340759889266, 318818.0, 318949.0, 318969.0, 320685.0, 321178.0, 25212.873935630938, 25991.48017039611, 26618.866905666124, 26661.466770664865, 27595.724042759317, 41991.75103112111, 42186.7890660557, 42514.0, 42735.0, 43554.78222608867, 35412.291754165286, 35870.282594347445, 36021.63978360183, 36527.98192198909, 36836.447453287685, 36009.279814404086, 36450.453243201904, 36578.26843463169, 37305.44041839429, 37419.0, 35781.82109089438, 35930.28139437249, 36288.63711362852, 36403.63596364002, 36607.45088823723, 30535.694643053284, 32413.0, 33136.0, 33139.83430082834, 33162.33675326432, 25382.746172538038, 25837.741622583533, 25920.740792591834, 25921.22236332913, 26283.60574591421], "value": 16817.970907023948, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [345.57666858098816, 360.1608252771044, 361.1693105856529, 362.5106106755878, 388.9883303500896, 12929.612111636654, 16201.675966480678, 16395.67208655826, 17094.401695940644, 17989.550261243476, 14531.491397801079, 14541.636459088528, 14680.779788303184, 14705.264736763145, 14852.554423367315, 5043.218301163316, 5266.947330526684, 5267.1309233976535, 5576.302962129734, 6039.456448919596, 6120.0, 6142.262928448592, 6153.138560601519, 6156.168917196188, 6156.3843615638525, 5888.205092312547, 6065.666388348639, 6122.295935967376, 6142.170806941051, 6147.754089836423, 5818.709064546756, 5984.760609575612, 6008.639481631116, 6010.939890601104, 6125.846853828668, 5165.0, 5225.346831646044, 5231.2937753403185, 5232.450592687751, 5234.293370394986, 20365.694514582294, 20681.793182068137, 20940.79059209419, 21030.78969210319, 21063.157473701034, 1718.6820438218845, 1987.831034362081, 2082.4793801549613, 2329.0800133946996, 2405.56699794037, 8839.425437346616, 9075.863862042008, 9146.679866204717, 9312.0, 12675.958740026526, 1683.1331864090002, 1711.3496871188993, 1715.4939292908623, 1767.2312544043382, 1811.2845426056765, 66581.66709166471, 71531.0, 72025.6398718003, 72083.2791672087, 73012.26987730108, 8597.0, 9225.815483690289, 9306.813863722824, 10070.878027811403, 10208.948955255324, 11934.880651193376, 11999.380083688764, 12067.939660301643, 12083.275003499819, 12097.0, 6352.555321127476, 6373.808785736435, 6502.707378167994, 6504.38208370204, 6651.66741662915, 6133.110698948627, 6186.536009799283, 6340.302566717657, 6343.238811342576, 6359.459445947146, 3403.4384326586332, 3544.220271540257, 3580.9283814323567, 3649.525561676965, 3668.1013151777984, 1746.991265043692, 1769.8761086723805, 1818.2181661885252, 1841.048488602086, 1857.4984754116583, 858.3690987124459, 870.2646263906988, 879.090141703334, 892.6563273139888, 945.0455040409099, 17040.016266371815, 17165.141742912805, 17850.732239016426, 17906.28374865017, 18236.45290641283, 846.9618867150994, 859.6991053131354, 865.8528050231475, 871.7951281448854, 875.1948207648978, 7409.666565004588, 9969.102780749767, 9980.750481238027, 10067.412586014685, 10126.139278161292, 388028.0, 388840.0, 394886.0, 397115.0, 400924.0, 75614.62192689111, 76364.61817690876, 76955.0, 77279.61360193163, 78699.21300786918, 871.4379225399582, 885.9512726800087, 887.2946007923587, 892.5715656484793, 896.9910300897169, 14674.486392976194, 15447.691046178788, 15977.68044639124, 15984.280707367963, 16015.199240037718, 39282.410763837994, 39319.213615726956, 39538.209235815695, 41531.584684152775, 41746.0, 51605.741971289906, 55223.72388138194, 55259.171112432545, 56304.34021788571, 58480.70759646175, 11360.886391136313, 12053.071508558589, 12168.08739344535, 12194.329311887932, 12308.692282693004, 12643.114981951176, 12753.61739147827, 12883.098183127091, 12970.351482425653, 13566.253856038013, 10648.733781655521, 10699.304545204537, 10725.946370268099, 10982.505787239754, 11437.08503319749, 11050.0, 11273.943630281796, 11498.310101393608, 11581.478833452345, 11852.229605075643, 10963.397013164353, 11065.944670276596, 11213.102951763676, 11252.156088293246, 11404.258723182966, 11642.6507204784, 11650.126240532163, 11742.765144697229, 11860.347680877634, 12042.578509752117, 6833.282505337067, 7189.137303523611, 7198.74804381865, 7464.514806537558, 11123.666290011313], "value": 8430.904674772813, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1268.4038501904101, 1362.0737898229204, 1397.0779285671456, 1465.5310300703773, 1678.5467923660613, 6385.648789316591, 7186.209516953131, 7435.665395057222, 7446.218147094558, 7660.578668173248, 7477.065366829146, 7569.772906812805, 7582.355499782511, 7582.658780354884, 7585.469017168801, 2119.6608542633144, 2149.924752633658, 2150.311900191939, 2151.182550630766, 2153.8923053847325, 2075.2632815350557, 2121.278765219825, 2125.8405619578516, 2132.0299263834995, 2139.839512036596, 2077.740282464692, 2093.288281984125, 2104.189886893542, 2105.3894370632497, 2125.893705314728, 2066.3077868913856, 2067.5658111796392, 2068.4725395024325, 2069.699893515447, 2071.554615757604, 1995.281698588507, 2067.059487932987, 2067.3074520035807, 2067.9689804652944, 2071.6478198706254, 7226.783196504113, 7501.849963000709, 7533.35966442853, 7625.046869141357, 7635.923640763577, 4051.756894586334, 4177.4569305990335, 4245.893852653678, 4246.065865509614, 4251.6386107180615, 2653.548896687568, 2763.392053748172, 2826.307554649124, 2828.3636181859124, 2830.4763618730394, 899.132337294514, 899.8875140607424, 915.0346384564282, 941.4163218804385, 944.5324564340626, 9916.702498925044, 10116.291859569834, 10164.44095574743, 10189.032041956076, 10197.949010254975, 3834.4440056191697, 3996.420519024783, 4066.3087275163293, 4153.771542565128, 4154.0, 8765.298776097898, 8766.430182038148, 8766.736997889946, 8776.341774366949, 8777.736667899973, 4186.539480657125, 4187.413762073312, 4187.539370669224, 4189.204051230317, 4189.811458484375, 3364.4953257011643, 3683.4843121962413, 3770.9245815083545, 3798.2023775007005, 3828.1386687994977, 3568.1793187567005, 3628.1836586767768, 3746.5129533160516, 3760.417135344026, 3761.8683346082757, 1185.2947496239724, 1212.5755985405037, 1212.6422705301957, 1215.7082300247878, 1225.993870030662, 704.4082970304969, 734.7465124532027, 786.7128498098267, 809.6720828064525, 831.6361167685002, 4830.855074347775, 4881.0, 4905.362302900671, 4952.613268284886, 5026.246063090565, 381.18046200668783, 381.88161669882425, 387.64336810134745, 396.1878149792913, 408.4220827529073, 3282.538071571073, 3382.340443613521, 3397.8131202784084, 3420.281740834403, 3437.6562343765922, 8434.704785332484, 8645.481271123752, 8675.696350627697, 8863.379563430499, 9254.86117708235, 8732.8690069649, 8750.518721470253, 8754.781130471662, 8756.474611523328, 8766.693165739169, 6493.772717954849, 6755.560888542229, 6818.556793808387, 6824.18109826824, 7013.2986701329455, 5331.600129990189, 5413.079776438094, 5500.9174862377895, 5560.527355174693, 5588.804391846266, 8702.91297087021, 8767.430117042371, 8792.956035219782, 8856.64573417056, 8926.107389261022, 8131.634076466455, 8429.620667069874, 8442.577871106543, 8681.696140635047, 8873.689420870238, 5931.703414829328, 6385.201849768779, 6540.640264785292, 6692.59844409337, 6723.26044135135, 7127.8574428512175, 7148.320909513588, 7195.388391986739, 7214.89177662346, 7281.781546553612, 6462.386073323027, 6615.305392933865, 6661.3338666132995, 6742.898856517058, 6755.695993680394, 6342.048692695948, 6402.263739669997, 6467.417932386108, 6512.08830763684, 6560.737570497126, 5938.7231745174995, 6047.78832740852, 6053.424924632153, 6056.57603967718, 6058.273007238983, 4480.50662972489, 4512.345709872116, 4515.14212299662, 4543.386642803312, 4624.28323609841, 4383.145286669069, 4492.450963738741, 4508.639308855218, 4582.175208462509, 4607.07858428309], "value": 3887.2637162634396, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [290.068878898735, 297.39034978294495, 297.94082038353656, 300.9458297506448, 301.74201058095326, 4872.4640289568115, 4872.683275587085, 4889.65772395932, 4902.166631672615, 4934.728589927553, 4855.2959820826045, 4877.804887804484, 4878.950840646928, 4884.145274576944, 4885.853424397274, 3680.5215322008166, 3751.8686845960397, 3796.316663000659, 3805.46723458716, 3849.6709490758108, 3825.2158307547024, 3827.7129215308823, 3831.4827498287655, 3832.4897192339063, 3840.465292906682, 3781.2248489059816, 3793.867214647488, 3796.354619714655, 3803.695704343646, 3819.4079917612817, 3606.981965090184, 3641.289948460051, 3736.953652977171, 3751.3997760358484, 3777.1312598102454, 3328.4508056170703, 3329.1344250495044, 3331.3170799986187, 3341.448660970937, 3361.294128233074, 4664.603508701764, 4676.883077923045, 4714.363560919266, 4716.716996980193, 4722.3152642866935, 4130.54563997963, 4289.849855255083, 4336.609705126522, 4336.696431249814, 4338.82644694215, 4986.202207646796, 5006.448001119628, 5010.949890501085, 5016.949830501685, 5027.572656324217, 3642.562892452896, 3655.780653160792, 3670.889873303805, 3673.761205521659, 3681.3189559931498, 5095.974520127375, 5248.422673505911, 5319.574434045306, 5340.225667278261, 5367.81212657559, 3700.685441737429, 3706.944395834065, 3713.922962340945, 3738.140227747633, 3749.2314075614436, 3776.546814382292, 3787.791671458041, 3790.298794722985, 3792.4311353297226, 3802.8478860845257, 4293.248681480728, 4307.729219880143, 4308.827646894089, 4311.1808756336195, 4331.523532411432, 4843.39457567804, 4994.300797888299, 5039.77321020555, 5040.243963405518, 5098.2352647103235, 1297.2864924291603, 1315.1648703073618, 1317.5586178630074, 1324.43711422645, 1327.0047464401698, 820.3970081989733, 848.9193526614962, 854.5641722721457, 857.4812238595684, 857.8241460500583, 4258.957410425918, 4346.565343465628, 4355.477342718831, 4356.499002614676, 4376.759278239728, 5054.671446356048, 5114.64197506171, 5157.690538567698, 5170.922436163461, 5183.792648294101, 4389.1660584488845, 4399.768064941822, 4411.228035093845, 4414.646828253732, 4435.933460998088, 2667.213172114231, 2738.507513405199, 2764.2951047483166, 2769.376890199729, 2778.1110044785473, 4864.0, 4873.6832105913, 4895.877603059881, 4901.901961960741, 4903.215485522299, 5088.974555127201, 5252.448492908266, 5252.579793616502, 5273.894522109536, 5289.867753306198, 4899.387576552931, 4899.534544218293, 4940.5544255592995, 4946.431160416454, 4956.0, 5157.381114266162, 5172.63791534604, 5199.272101905661, 5213.895722085613, 5247.2129180623215, 4971.353724015855, 5082.949170508247, 5091.439941606494, 5122.590192784643, 5137.614678899172, 4867.975660121819, 4872.14737420957, 4876.853694389174, 4906.116898958222, 4908.7545622719435, 3767.9058023549633, 3772.2832661794173, 3787.6780473660046, 3801.695864330902, 3813.389857622767, 5029.44676085623, 5252.737363131904, 5262.421133675216, 5293.179557168645, 5299.33758280215, 4971.718665680633, 5012.974935125301, 5038.974805125951, 5044.243363495359, 5045.066662667418, 5036.0, 5050.191969285043, 5050.873728156826, 5063.670861393997, 5105.92341114891, 4849.878753031202, 4900.444281909002, 4977.651564390458, 4981.6014718823135, 5002.749862506787, 4847.394075740533, 4972.204447288416, 5039.168537191323, 5052.722100284373, 5065.56942659878, 4761.523847615349, 4868.2210846264425, 4869.4400143982475, 4869.926951095807, 4878.756062196947], "value": 3813.6534898607633, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [646.8512242184297, 656.2256537286004, 683.5078743304819, 726.7129483853878, 780.9140994490607, 12149.817752733716, 13013.219206847572, 13014.93492532536, 13023.218606883582, 13052.28212448315, 13063.0, 13856.376463059161, 13882.652933676663, 13923.234222117804, 13929.094608850442, 636.1094467745147, 765.4297548326505, 773.5706682791063, 787.6888628991545, 793.1592511937336, 776.0532150776072, 792.0139426414122, 793.654760179321, 793.7221972309675, 793.8531371696225, 832.5337810825927, 835.4945258118842, 837.2883049408015, 837.351052933975, 837.6900546797693, 665.6139439125344, 685.6023506366296, 833.7665453672981, 834.1325021977136, 834.2283387866199, 505.9949400505985, 506.3872714016045, 589.7434615942079, 598.9940100599025, 601.0503404620689, 12262.570810021696, 12310.076744244217, 12326.75346493065, 12342.568010119603, 12348.444320005621, 11914.46384912681, 12778.0, 13154.408051637603, 13500.864991350158, 13751.449942002308, 11549.31399821843, 12073.698157546043, 12252.632421027383, 12480.875191248062, 12751.0, 4016.9196616067516, 4102.487189101363, 4182.581741825824, 4224.619784219435, 4226.894327641833, 64314.67842660757, 65820.67089664521, 66671.333286667, 67194.66402667956, 67389.66305168491, 9191.448513089235, 9322.95338523303, 9325.720228393158, 9327.626894924262, 9832.803343933081, 17625.823741762673, 17714.557136071442, 17784.55538611545, 17785.19966601506, 17843.643127137646, 6824.897626535606, 6881.41507971818, 6884.759033433806, 6972.546784458994, 7150.249223831527, 3703.2963736890442, 3718.4980027695915, 3736.3648179809497, 3768.736188466781, 3785.356489396809, 2679.61145633882, 2716.8641567921527, 2737.178846346128, 2741.150243424545, 2745.5195340815276, 469.9130660827758, 472.53691382445396, 478.8722558375046, 480.7115730561635, 481.2444462194391, 547.6713971616998, 562.1427323331951, 576.1165367336538, 587.3832475900288, 591.795830438498, 7475.663595138232, 7694.07671079474, 7847.960760196277, 7856.5678887661725, 7954.681812727426, 369.0386543055302, 393.28814845129835, 421.9914404573073, 447.25531989238203, 459.1757794758417, 3824.3746407776584, 4488.236999710057, 4505.896055466432, 4531.524189960072, 4587.564181402761, 101537.0, 101562.49218753859, 102535.4873225644, 104079.4796026015, 106567.46716266368, 89080.0, 89470.0, 93055.0, 93559.53220233855, 95218.0, 80288.0, 81711.0, 82616.58691706503, 83068.75396869052, 84201.0, 8202.671893124209, 8616.0, 8738.606762695821, 8776.0, 8787.209151176425, 32003.519947200344, 37273.81363093167, 43179.36951316865, 44337.0, 44725.77637111924, 60028.399716002285, 60604.090938635076, 64896.0, 67113.66443167948, 68506.65746671235, 11686.24039437434, 11727.413629318671, 11744.647660570197, 11751.059915206592, 12301.44643491027, 12975.0, 13242.602721918358, 13362.665933351354, 13616.114952528054, 13920.164790112625, 11806.527738890692, 12279.079069069678, 12372.690682733004, 12426.440810163384, 12692.365381730691, 12678.239305641691, 12744.74510509803, 12796.232226066466, 13074.869251307366, 13457.596272111852, 12379.62861114168, 12454.43955022008, 12586.118971671895, 13233.691577105723, 13344.26606536611, 9955.601775928882, 9970.950145249228, 10703.732406689895, 10738.19463540222, 10882.510287037261, 10513.158947284352, 10877.67366978992, 10878.564857405616, 10895.564177432814, 10948.56205751793], "value": 6652.9705930953305, "unit": "score"}], "name": "dromaeo_css", "value": 6369.577766662453, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 115.0, 114.0, 115.0, 113.0, 113.0, 114.0, 114.0, 113.0, 113.0], "value": 112.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 122.0, 122.0, 185.0, 124.0, 123.0, 158.0, 123.0, 189.0, 129.0], "value": 142.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 163.0, 161.0, 162.0, 162.0, 160.0, 160.0, 162.0, 161.0, 160.0], "value": 161.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 75.0, 117.0, 76.0, 77.0, 77.0, 76.0, 105.0, 75.0], "value": 82.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 86.0, 114.0, 84.0, 85.0, 85.0, 118.0, 84.0, 85.0, 124.0], "value": 94.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 117.0, 116.0, 117.0, 117.0, 116.0, 117.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 147.0, 148.0, 146.0, 147.0, 146.0, 146.0, 146.0, 146.0], "value": 146.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 94.0, 95.0, 95.0, 96.0, 96.0, 95.0, 95.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 62.0, 63.0, 64.0, 68.0, 71.0, 62.0, 62.0, 64.0], "value": 64.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 65.0, 64.0, 65.0, 65.0, 65.0, 64.0, 67.0, 65.0], "value": 64.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 80.0, 79.0, 80.0, 81.0, 80.0, 78.0, 79.0, 80.0, 84.0], "value": 80.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 140.0, 139.0, 144.0, 128.0, 139.0, 129.0, 131.0, 186.0, 141.0], "value": 141.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 173.0, 173.0, 165.0, 173.0, 170.0, 166.0, 167.0, 168.0, 166.0], "value": 169.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 68.0, 67.0, 68.0, 67.0, 67.0, 67.0, 67.0, 66.0, 66.0], "value": 67.4, "unit": "score"}], "name": "kraken", "value": 1539.6000000000001, "alertThreshold": 2.0}]} 08:05:36 INFO - Return code: 0 08:05:36 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:05:36 INFO - # TBPL SUCCESS # 08:05:36 INFO - Running post-action listener: _resource_record_post_action 08:05:36 INFO - [mozharness: 2016-08-04 15:05:36.286142Z] Finished run-tests step (success) 08:05:36 INFO - Running post-run listener: _resource_record_post_run 08:05:36 INFO - Total resource usage - Wall time: 1201s; CPU: 13.0%; Read bytes: 4096; Write bytes: 532463616; Read time: 12; Write time: 367184 08:05:36 INFO - TinderboxPrint: CPU usage
13.0% 08:05:36 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 08:05:36 INFO - TinderboxPrint: I/O write bytes / time
532,463,616 / 367,184 08:05:36 INFO - TinderboxPrint: CPU idle
8,339.7 (87.0%) 08:05:36 INFO - TinderboxPrint: CPU user
1,202.8 (12.5%) 08:05:36 INFO - TinderboxPrint: Swap in / out
0 / 0 08:05:36 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 244002816; Read time: 0; Write time: 182040 08:05:36 INFO - run-tests - Wall time: 1185s; CPU: 13.0%; Read bytes: 0; Write bytes: 284008448; Read time: 0; Write time: 184788 08:05:36 INFO - Running post-run listener: _upload_blobber_files 08:05:36 INFO - Blob upload gear active. 08:05:36 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:05:36 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 08:05:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:05:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:05:37 INFO - (blobuploader) - INFO - Open directory for files ... 08:05:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:05:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:05:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:05:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:05:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:05:38 INFO - (blobuploader) - INFO - Done attempting. 08:05:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:05:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:05:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:05:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:05:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:05:38 INFO - (blobuploader) - INFO - Done attempting. 08:05:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:05:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:05:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:05:43 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:05:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:05:43 INFO - (blobuploader) - INFO - Done attempting. 08:05:43 INFO - (blobuploader) - INFO - Iteration through files over. 08:05:43 INFO - Return code: 0 08:05:43 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:05:43 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:05:43 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/72a8711c7af055bcd69535807471055a2ddcd61122bfbb0e0d13c88caa91cc28a9c5972e6dac6389562676e5ffecdeeca3e53278499b4d8875a1931eb7e2079f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/92aa47f5893107cbac204c5850ea40a67dd81a17de7a68ae1d86623c43fb9f26a9bc4c05c0e507b5c7a103dbd5bd260172a4f9f8bb61ecafc05da75481fa0eb8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f72c4e036f4af69c6e88ba4b945715fbc32c22a1a1348ce4a80870805466d7322ee756e44aec44b0089d649ecdb645bf008096ca3987d132e81ee84676d48a3b"} 08:05:43 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:05:43 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:05:43 INFO - Contents: 08:05:43 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/72a8711c7af055bcd69535807471055a2ddcd61122bfbb0e0d13c88caa91cc28a9c5972e6dac6389562676e5ffecdeeca3e53278499b4d8875a1931eb7e2079f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/92aa47f5893107cbac204c5850ea40a67dd81a17de7a68ae1d86623c43fb9f26a9bc4c05c0e507b5c7a103dbd5bd260172a4f9f8bb61ecafc05da75481fa0eb8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f72c4e036f4af69c6e88ba4b945715fbc32c22a1a1348ce4a80870805466d7322ee756e44aec44b0089d649ecdb645bf008096ca3987d132e81ee84676d48a3b"} 08:05:43 INFO - Running post-run listener: copy_logs_to_upload_dir 08:05:43 INFO - Copying logs to upload dir... 08:05:43 INFO - mkdir: /builds/slave/test/build/upload/logs 08:05:43 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1240.714951 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-08-04 08:05:42.837955) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-04 08:05:42.841699) ========= 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=bb9b54edd4a927dc735d112f000001d9-1470321745.808634-1729226070 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/72a8711c7af055bcd69535807471055a2ddcd61122bfbb0e0d13c88caa91cc28a9c5972e6dac6389562676e5ffecdeeca3e53278499b4d8875a1931eb7e2079f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/92aa47f5893107cbac204c5850ea40a67dd81a17de7a68ae1d86623c43fb9f26a9bc4c05c0e507b5c7a103dbd5bd260172a4f9f8bb61ecafc05da75481fa0eb8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f72c4e036f4af69c6e88ba4b945715fbc32c22a1a1348ce4a80870805466d7322ee756e44aec44b0089d649ecdb645bf008096ca3987d132e81ee84676d48a3b"} build_url:https://queue.taskcluster.net/v1/task/JBhRYW7uQVOgy35LGmTv1Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011432 build_url: 'https://queue.taskcluster.net/v1/task/JBhRYW7uQVOgy35LGmTv1Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/72a8711c7af055bcd69535807471055a2ddcd61122bfbb0e0d13c88caa91cc28a9c5972e6dac6389562676e5ffecdeeca3e53278499b4d8875a1931eb7e2079f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/92aa47f5893107cbac204c5850ea40a67dd81a17de7a68ae1d86623c43fb9f26a9bc4c05c0e507b5c7a103dbd5bd260172a4f9f8bb61ecafc05da75481fa0eb8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f72c4e036f4af69c6e88ba4b945715fbc32c22a1a1348ce4a80870805466d7322ee756e44aec44b0089d649ecdb645bf008096ca3987d132e81ee84676d48a3b"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-04 08:05:42.868009) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-04 08:05:42.868384) ========= 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=bb9b54edd4a927dc735d112f000001d9-1470321745.808634-1729226070 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004461 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-04 08:05:42.950835) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-04 08:05:42.951216) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-04 08:05:42.951675) ========= ========= Total master_lag: 0.17 =========