builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-011 starttime: 1460661253.22 results: success (0) buildid: 20160414115241 builduid: 205ea0318ab74047a04cf4baf35fe1b9 revision: d0b6d063cf4981b3c893f511e84f6aac3a96b2f9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-14 12:14:13.223996) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-14 12:14:13.224520) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-14 12:14:13.224814) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-14 12:14:13.242107) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 12:14:13.242426) ========= 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=5cf47e208febbcd81da23b2e0000026f-1460659021.283918-452146743 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-14 12:14:13-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 42.8M=0s 2016-04-14 12:14:13 (42.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.162525 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 12:14:13.418322) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 12:14:13.418644) ========= 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=5cf47e208febbcd81da23b2e0000026f-1460659021.283918-452146743 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016232 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 12:14:13.467685) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-14 12:14:13.468035) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev d0b6d063cf4981b3c893f511e84f6aac3a96b2f9 --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 d0b6d063cf4981b3c893f511e84f6aac3a96b2f9 --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=5cf47e208febbcd81da23b2e0000026f-1460659021.283918-452146743 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-14 12:14:13,714 truncating revision to first 12 chars 2016-04-14 12:14:13,714 Setting DEBUG logging. 2016-04-14 12:14:13,714 attempt 1/10 2016-04-14 12:14:13,714 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/d0b6d063cf49?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-14 12:14:14,776 unpacking tar archive at: fx-team-d0b6d063cf49/testing/mozharness/ program finished with exit code 0 elapsedTime=1.322286 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-14 12:14:14.804323) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-14 12:14:14.804703) ========= script_repo_revision: d0b6d063cf4981b3c893f511e84f6aac3a96b2f9 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-14 12:14:14.805122) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-14 12:14:14.805496) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-14 12:14:14.815043) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2016-04-14 12:14:14.815384) ========= /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=5cf47e208febbcd81da23b2e0000026f-1460659021.283918-452146743 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:14:15 INFO - MultiFileLogger online at 20160414 12:14:15 in /builds/slave/test 12:14:15 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 12:14:15 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:14:15 INFO - {'append_to_log': False, 12:14:15 INFO - 'base_work_dir': '/builds/slave/test', 12:14:15 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 12:14:15 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:14:15 INFO - 'branch': 'Fx-Team-Non-PGO', 12:14:15 INFO - 'buildbot_json_path': 'buildprops.json', 12:14:15 INFO - 'config_files': ('talos/linux_config.py',), 12:14:15 INFO - 'default_actions': ('clobber', 12:14:15 INFO - 'read-buildbot-config', 12:14:15 INFO - 'download-and-extract', 12:14:15 INFO - 'populate-webroot', 12:14:15 INFO - 'create-virtualenv', 12:14:15 INFO - 'install', 12:14:15 INFO - 'run-tests'), 12:14:15 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:14:15 INFO - 'download_minidump_stackwalk': True, 12:14:15 INFO - 'download_symbols': 'ondemand', 12:14:15 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:14:15 INFO - 'tooltool.py': '/tools/tooltool.py', 12:14:15 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:14:15 INFO - '/tools/misc-python/virtualenv.py')}, 12:14:15 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:14:15 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:14:15 INFO - 'installer_path': 'installer.exe', 12:14:15 INFO - 'log_level': 'info', 12:14:15 INFO - 'log_name': 'talos', 12:14:15 INFO - 'log_to_console': True, 12:14:15 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:14:15 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:14:15 INFO - 'opt_config_files': (), 12:14:15 INFO - 'pip_index': False, 12:14:15 INFO - 'sps_profile': False, 12:14:15 INFO - 'sps_profile_interval': 0, 12:14:15 INFO - 'suite': 'dromaeojs', 12:14:15 INFO - 'system_bits': '32', 12:14:15 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:14:15 INFO - 'title': 'talos-linux64-ix-011', 12:14:15 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:14:15 INFO - 'use_talos_json': True, 12:14:15 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:14:15 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:14:15 INFO - 'work_dir': 'build'} 12:14:15 INFO - ##### 12:14:15 INFO - ##### Running clobber step. 12:14:15 INFO - ##### 12:14:15 INFO - Running pre-action listener: _resource_record_pre_action 12:14:15 INFO - Running main action method: clobber 12:14:15 INFO - rmtree: /builds/slave/test/build 12:14:15 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:14:16 INFO - Running post-action listener: _resource_record_post_action 12:14:16 INFO - ##### 12:14:16 INFO - ##### Running read-buildbot-config step. 12:14:16 INFO - ##### 12:14:16 INFO - Running pre-action listener: _resource_record_pre_action 12:14:16 INFO - Running main action method: read_buildbot_config 12:14:16 INFO - Using buildbot properties: 12:14:16 INFO - { 12:14:16 INFO - "project": "", 12:14:16 INFO - "product": "firefox", 12:14:16 INFO - "script_repo_revision": "production", 12:14:16 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 12:14:16 INFO - "repository": "", 12:14:16 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 12:14:16 INFO - "buildid": "20160414115241", 12:14:16 INFO - "pgo_build": "False", 12:14:16 INFO - "basedir": "/builds/slave/test", 12:14:16 INFO - "buildnumber": 2831, 12:14:16 INFO - "slavename": "talos-linux64-ix-011", 12:14:16 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 12:14:16 INFO - "platform": "ubuntu64_hw", 12:14:16 INFO - "scheduler": "tests-fx-team-linux64-talos", 12:14:16 INFO - "branch": "fx-team", 12:14:16 INFO - "repo_path": "integration/fx-team", 12:14:16 INFO - "revision": "d0b6d063cf4981b3c893f511e84f6aac3a96b2f9", 12:14:16 INFO - "stage_platform": "linux64", 12:14:16 INFO - "builduid": "205ea0318ab74047a04cf4baf35fe1b9", 12:14:16 INFO - "slavebuilddir": "test" 12:14:16 INFO - } 12:14:16 INFO - Found installer url https://queue.taskcluster.net/v1/task/O13gFoQRTV-lV4uQZhnW3A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 12:14:16 INFO - Running post-action listener: _resource_record_post_action 12:14:16 INFO - ##### 12:14:16 INFO - ##### Running download-and-extract step. 12:14:16 INFO - ##### 12:14:16 INFO - Running pre-action listener: _resource_record_pre_action 12:14:16 INFO - Running main action method: download_and_extract 12:14:16 INFO - mkdir: /builds/slave/test/build/tests 12:14: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')]} 12:14:16 INFO - https://queue.taskcluster.net/v1/task/O13gFoQRTV-lV4uQZhnW3A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 12:14:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O13gFoQRTV-lV4uQZhnW3A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 12:14:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O13gFoQRTV-lV4uQZhnW3A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 12:14:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O13gFoQRTV-lV4uQZhnW3A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 12:14:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O13gFoQRTV-lV4uQZhnW3A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 12:14:19 INFO - Downloaded 1361 bytes. 12:14:19 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 12:14:19 INFO - Using the following test package requirements: 12:14:19 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 12:14:19 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 12:14:19 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 12:14:19 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 12:14:19 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 12:14:19 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 12:14:19 INFO - u'jsshell-linux-x86_64.zip'], 12:14:19 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 12:14:19 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 12:14:19 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 12:14:19 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 12:14:19 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 12:14:19 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 12:14:19 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 12:14:19 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 12:14:19 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 12:14:19 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 12:14:19 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 12:14:19 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 12:14: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')]} 12:14:19 INFO - https://queue.taskcluster.net/v1/task/O13gFoQRTV-lV4uQZhnW3A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:14:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O13gFoQRTV-lV4uQZhnW3A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 12:14:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O13gFoQRTV-lV4uQZhnW3A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 12:14:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O13gFoQRTV-lV4uQZhnW3A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 12:14:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O13gFoQRTV-lV4uQZhnW3A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 12:14:26 INFO - Downloaded 22203341 bytes. 12:14:26 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 12:14:26 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 12:14:27 INFO - Return code: 0 12:14:27 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 12:14: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')]} 12:14:27 INFO - https://queue.taskcluster.net/v1/task/O13gFoQRTV-lV4uQZhnW3A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:14:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O13gFoQRTV-lV4uQZhnW3A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 12:14:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O13gFoQRTV-lV4uQZhnW3A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 12:14:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O13gFoQRTV-lV4uQZhnW3A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 12:14:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O13gFoQRTV-lV4uQZhnW3A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 12:14:33 INFO - Downloaded 22203341 bytes. 12:14:33 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 12:14:33 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 12:14:35 INFO - Return code: 0 12:14:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:14:35 INFO - https://queue.taskcluster.net/v1/task/O13gFoQRTV-lV4uQZhnW3A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 12:14:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O13gFoQRTV-lV4uQZhnW3A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 12:14:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O13gFoQRTV-lV4uQZhnW3A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 12:14:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O13gFoQRTV-lV4uQZhnW3A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 12:14:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O13gFoQRTV-lV4uQZhnW3A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 12:14:36 INFO - Downloaded 10841076 bytes. 12:14:36 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 12:14:36 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 12:14:36 INFO - Return code: 0 12:14:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:14:36 INFO - https://queue.taskcluster.net/v1/task/O13gFoQRTV-lV4uQZhnW3A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 12:14:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O13gFoQRTV-lV4uQZhnW3A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 12:14:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O13gFoQRTV-lV4uQZhnW3A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 12:14:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O13gFoQRTV-lV4uQZhnW3A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 12:14:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O13gFoQRTV-lV4uQZhnW3A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 12:14:39 INFO - Downloaded 54451640 bytes. 12:14:39 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/O13gFoQRTV-lV4uQZhnW3A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 12:14:39 INFO - mkdir: /builds/slave/test/properties 12:14:39 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:14:39 INFO - Writing to file /builds/slave/test/properties/build_url 12:14:39 INFO - Contents: 12:14:39 INFO - build_url:https://queue.taskcluster.net/v1/task/O13gFoQRTV-lV4uQZhnW3A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 12:14:40 INFO - Running post-action listener: _resource_record_post_action 12:14:40 INFO - Running post-action listener: set_extra_try_arguments 12:14:40 INFO - ##### 12:14:40 INFO - ##### Running populate-webroot step. 12:14:40 INFO - ##### 12:14:40 INFO - Running pre-action listener: _resource_record_pre_action 12:14:40 INFO - Running main action method: populate_webroot 12:14:40 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:14:40 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:14:40 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:14:40 INFO - '--tppagecycles', 12:14:40 INFO - '7'], 12:14:40 INFO - 'tests': ['tsvgm']}}, 12:14:40 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 12:14:40 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:14:40 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:14:40 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 12:14:40 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:14:40 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:14:40 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:14:40 INFO - 'talos_options': ['--disable-e10s'], 12:14:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:14:40 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:14:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:14:40 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:14:40 INFO - 'talos_options': ['--disable-e10s'], 12:14:40 INFO - 'tests': ['damp', 'tps']}, 12:14:40 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:14:40 INFO - 'tests': ['damp', 'tps']}, 12:14:40 INFO - 'g3': {'talos_options': ['--disable-e10s'], 12:14:40 INFO - 'tests': ['dromaeo_dom']}, 12:14:40 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:14:40 INFO - 'other': {'talos_options': ['--disable-e10s'], 12:14:40 INFO - 'tests': ['a11yr', 12:14:40 INFO - 'ts_paint', 12:14:40 INFO - 'tpaint', 12:14:40 INFO - 'sessionrestore', 12:14:40 INFO - 'sessionrestore_no_auto_restore', 12:14:40 INFO - 'tabpaint']}, 12:14:40 INFO - 'other-e10s': {'tests': ['a11yr', 12:14:40 INFO - 'ts_paint', 12:14:40 INFO - 'tpaint', 12:14:40 INFO - 'sessionrestore', 12:14:40 INFO - 'sessionrestore_no_auto_restore', 12:14:40 INFO - 'tabpaint']}, 12:14:40 INFO - 'other-e10s_l64': {'tests': ['a11yr', 12:14:40 INFO - 'ts_paint', 12:14:40 INFO - 'tpaint', 12:14:40 INFO - 'sessionrestore', 12:14:40 INFO - 'sessionrestore_no_auto_restore', 12:14:40 INFO - 'tabpaint']}, 12:14:40 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 12:14:40 INFO - 'ts_paint', 12:14:40 INFO - 'tpaint', 12:14:40 INFO - 'sessionrestore', 12:14:40 INFO - 'sessionrestore_no_auto_restore', 12:14:40 INFO - 'tabpaint']}, 12:14:40 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 12:14:40 INFO - 'tests': ['a11yr', 12:14:40 INFO - 'ts_paint', 12:14:40 INFO - 'tpaint', 12:14:40 INFO - 'sessionrestore', 12:14:40 INFO - 'sessionrestore_no_auto_restore', 12:14:40 INFO - 'tabpaint']}, 12:14:40 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 12:14:40 INFO - 'tests': ['a11yr', 12:14:40 INFO - 'ts_paint', 12:14:40 INFO - 'tpaint', 12:14:40 INFO - 'sessionrestore', 12:14:40 INFO - 'sessionrestore_no_auto_restore', 12:14:40 INFO - 'tabpaint']}, 12:14:40 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 12:14:40 INFO - 'tests': ['tsvgx', 12:14:40 INFO - 'tsvgr_opacity', 12:14:40 INFO - 'tart', 12:14:40 INFO - 'tscrollx', 12:14:40 INFO - 'cart']}, 12:14:40 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:14:40 INFO - 'tsvgr_opacity', 12:14:40 INFO - 'tart', 12:14:40 INFO - 'tscrollx', 12:14:40 INFO - 'cart']}, 12:14:40 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:14:40 INFO - 'talos_options': ['--disable-e10s'], 12:14:40 INFO - 'tests': ['tp5o']}, 12:14:40 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:14:40 INFO - 'tests': ['tp5o']}, 12:14:40 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:14:40 INFO - 'talos_options': ['--disable-e10s', 12:14:40 INFO - '--xperf_path', 12:14:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:14:40 INFO - 'tests': ['tp5n']}, 12:14:40 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:14:40 INFO - 'talos_options': ['--xperf_path', 12:14:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:14:40 INFO - 'tests': ['tp5n']}}, 12:14:40 INFO - 'talos.zip': {'path': '', 12:14:40 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:14:40 INFO - Running post-action listener: _resource_record_post_action 12:14:40 INFO - ##### 12:14:40 INFO - ##### Running create-virtualenv step. 12:14:40 INFO - ##### 12:14:40 INFO - Running pre-action listener: _resource_record_pre_action 12:14:40 INFO - Running main action method: create_virtualenv 12:14:40 INFO - Creating virtualenv /builds/slave/test/build/venv 12:14:40 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 12:14:40 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:14:40 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:14:40 INFO - Using real prefix '/usr' 12:14:40 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:14:41 INFO - Installing distribute.............................................................................................................................................................................................done. 12:14:43 INFO - Installing pip.................done. 12:14:43 INFO - Return code: 0 12:14:43 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:14:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:14:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:14:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:14:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:14:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:14:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:14:43 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 0x7f5511880f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x287a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29455a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d4410>, '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 0x29d5310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29d57a0>, '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': '5cf47e208febbcd81da23b2e0000026f-1460659021.283918-452146743', '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 12:14:43 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 12:14:43 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 12:14:43 INFO - Using env: {'DISPLAY': ':0', 12:14:43 INFO - 'HOME': '/home/cltbld', 12:14:43 INFO - 'LANG': 'en_US.UTF-8', 12:14:43 INFO - 'LANGUAGE': 'en_US:en', 12:14:43 INFO - 'LOGNAME': 'cltbld', 12:14:43 INFO - 'MAIL': '/var/mail/cltbld', 12:14:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:14:43 INFO - 'MOZ_NO_REMOTE': '1', 12:14:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:14:43 INFO - 'NO_EM_RESTART': '1', 12:14:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:14:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:14:43 INFO - 'PWD': '/builds/slave/test', 12:14:43 INFO - 'SHELL': '/bin/bash', 12:14:43 INFO - 'SHLVL': '1', 12:14:43 INFO - 'TERM': 'linux', 12:14:43 INFO - 'TMOUT': '86400', 12:14:43 INFO - 'USER': 'cltbld', 12:14:43 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1460659021.283918-452146743', 12:14:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:14:43 INFO - '_': '/tools/buildbot/bin/python'} 12:14:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:14:43 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 12:14:43 INFO - Cleaning up... 12:14:43 INFO - Return code: 0 12:14:43 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 12:14:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:14:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:14:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:14:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:14:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:14:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:14:43 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>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5511880f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x287a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29455a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d4410>, '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 0x29d5310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29d57a0>, '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': '5cf47e208febbcd81da23b2e0000026f-1460659021.283918-452146743', '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 12:14:43 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>=0.7.1'] in /builds/slave/test/build 12:14:43 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>=0.7.1 12:14:43 INFO - Using env: {'DISPLAY': ':0', 12:14:43 INFO - 'HOME': '/home/cltbld', 12:14:43 INFO - 'LANG': 'en_US.UTF-8', 12:14:43 INFO - 'LANGUAGE': 'en_US:en', 12:14:43 INFO - 'LOGNAME': 'cltbld', 12:14:43 INFO - 'MAIL': '/var/mail/cltbld', 12:14:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:14:43 INFO - 'MOZ_NO_REMOTE': '1', 12:14:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:14:43 INFO - 'NO_EM_RESTART': '1', 12:14:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:14:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:14:43 INFO - 'PWD': '/builds/slave/test', 12:14:43 INFO - 'SHELL': '/bin/bash', 12:14:43 INFO - 'SHLVL': '1', 12:14:43 INFO - 'TERM': 'linux', 12:14:43 INFO - 'TMOUT': '86400', 12:14:43 INFO - 'USER': 'cltbld', 12:14:43 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1460659021.283918-452146743', 12:14:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:14:43 INFO - '_': '/tools/buildbot/bin/python'} 12:14:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:14:43 INFO - Downloading/unpacking psutil>=0.7.1 12:14:43 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 12:14:43 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 12:14:43 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 12:14:43 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 12:14:43 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 12:14:43 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 12:14:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:14:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:14:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:14:45 INFO - Installing collected packages: psutil 12:14:45 INFO - Running setup.py install for psutil 12:14:45 INFO - building 'psutil._psutil_linux' extension 12:14:45 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 12:14:45 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 12:14:45 INFO - building 'psutil._psutil_posix' extension 12:14:45 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 12:14:45 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 12:14:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:14:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:14:46 INFO - Successfully installed psutil 12:14:46 INFO - Cleaning up... 12:14:46 INFO - Return code: 0 12:14:46 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 12:14:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:14:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:14:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:14:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:14:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:14:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:14:46 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.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5511880f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x287a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29455a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d4410>, '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 0x29d5310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29d57a0>, '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': '5cf47e208febbcd81da23b2e0000026f-1460659021.283918-452146743', '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 12:14:46 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.0.0'] in /builds/slave/test/build 12:14:46 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.0.0 12:14:46 INFO - Using env: {'DISPLAY': ':0', 12:14:46 INFO - 'HOME': '/home/cltbld', 12:14:46 INFO - 'LANG': 'en_US.UTF-8', 12:14:46 INFO - 'LANGUAGE': 'en_US:en', 12:14:46 INFO - 'LOGNAME': 'cltbld', 12:14:46 INFO - 'MAIL': '/var/mail/cltbld', 12:14:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:14:46 INFO - 'MOZ_NO_REMOTE': '1', 12:14:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:14:46 INFO - 'NO_EM_RESTART': '1', 12:14:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:14:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:14:46 INFO - 'PWD': '/builds/slave/test', 12:14:46 INFO - 'SHELL': '/bin/bash', 12:14:46 INFO - 'SHLVL': '1', 12:14:46 INFO - 'TERM': 'linux', 12:14:46 INFO - 'TMOUT': '86400', 12:14:46 INFO - 'USER': 'cltbld', 12:14:46 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1460659021.283918-452146743', 12:14:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:14:46 INFO - '_': '/tools/buildbot/bin/python'} 12:14:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:14:46 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 12:14:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:14:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:14:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:14:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:14:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:14:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:14:48 INFO - Downloading mozsystemmonitor-0.0.tar.gz 12:14:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:14:48 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 12:14:48 INFO - Installing collected packages: mozsystemmonitor 12:14:48 INFO - Running setup.py install for mozsystemmonitor 12:14:48 INFO - Successfully installed mozsystemmonitor 12:14:48 INFO - Cleaning up... 12:14:48 INFO - Return code: 0 12:14:48 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:14:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:14:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:14:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:14:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:14:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:14:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:14:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f5511880f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x287a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29455a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d4410>, '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 0x29d5310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29d57a0>, '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': '5cf47e208febbcd81da23b2e0000026f-1460659021.283918-452146743', '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 12:14:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 12:14:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 12:14:48 INFO - Using env: {'DISPLAY': ':0', 12:14:48 INFO - 'HOME': '/home/cltbld', 12:14:48 INFO - 'LANG': 'en_US.UTF-8', 12:14:48 INFO - 'LANGUAGE': 'en_US:en', 12:14:48 INFO - 'LOGNAME': 'cltbld', 12:14:48 INFO - 'MAIL': '/var/mail/cltbld', 12:14:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:14:48 INFO - 'MOZ_NO_REMOTE': '1', 12:14:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:14:48 INFO - 'NO_EM_RESTART': '1', 12:14:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:14:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:14:48 INFO - 'PWD': '/builds/slave/test', 12:14:48 INFO - 'SHELL': '/bin/bash', 12:14:48 INFO - 'SHLVL': '1', 12:14:48 INFO - 'TERM': 'linux', 12:14:48 INFO - 'TMOUT': '86400', 12:14:48 INFO - 'USER': 'cltbld', 12:14:48 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1460659021.283918-452146743', 12:14:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:14:48 INFO - '_': '/tools/buildbot/bin/python'} 12:14:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:14:48 INFO - Downloading/unpacking blobuploader==1.2.4 12:14:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:14:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:14:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:14:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:14:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:14:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:14:50 INFO - Downloading blobuploader-1.2.4.tar.gz 12:14:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:14:50 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:14:50 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 12:14:50 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 12:14:50 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 12:14:50 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 12:14:50 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 12:14:50 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 12:14:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:14:50 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:14:50 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 12:14:50 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 12:14:50 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 12:14:50 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 12:14:50 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 12:14:50 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 12:14:51 INFO - Downloading docopt-0.6.1.tar.gz 12:14:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:14:51 INFO - Installing collected packages: blobuploader, requests, docopt 12:14:51 INFO - Running setup.py install for blobuploader 12:14:51 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:14:51 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:14:51 INFO - Running setup.py install for requests 12:14:51 INFO - Running setup.py install for docopt 12:14:51 INFO - Successfully installed blobuploader requests docopt 12:14:51 INFO - Cleaning up... 12:14:51 INFO - Return code: 0 12:14:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:14: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')]} 12:14:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:14:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:14: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')]} 12:14:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:14:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:14:51 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 0x7f5511880f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x287a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29455a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d4410>, '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 0x29d5310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29d57a0>, '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': '5cf47e208febbcd81da23b2e0000026f-1460659021.283918-452146743', '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 12:14:51 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 12:14:51 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 12:14:51 INFO - Using env: {'DISPLAY': ':0', 12:14:51 INFO - 'HOME': '/home/cltbld', 12:14:51 INFO - 'LANG': 'en_US.UTF-8', 12:14:51 INFO - 'LANGUAGE': 'en_US:en', 12:14:51 INFO - 'LOGNAME': 'cltbld', 12:14:51 INFO - 'MAIL': '/var/mail/cltbld', 12:14:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:14:51 INFO - 'MOZ_NO_REMOTE': '1', 12:14:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:14:51 INFO - 'NO_EM_RESTART': '1', 12:14:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:14:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:14:51 INFO - 'PWD': '/builds/slave/test', 12:14:51 INFO - 'SHELL': '/bin/bash', 12:14:51 INFO - 'SHLVL': '1', 12:14:51 INFO - 'TERM': 'linux', 12:14:51 INFO - 'TMOUT': '86400', 12:14:51 INFO - 'USER': 'cltbld', 12:14:51 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1460659021.283918-452146743', 12:14:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:14:51 INFO - '_': '/tools/buildbot/bin/python'} 12:14:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:14:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:14:52 INFO - Running setup.py (path:/tmp/pip-QyGQcD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:14:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:14:52 INFO - Running setup.py (path:/tmp/pip-13UGyc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:14:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:14:52 INFO - Running setup.py (path:/tmp/pip-6opkvy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:14:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:14:52 INFO - Running setup.py (path:/tmp/pip-LIWiHp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:14:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:14:52 INFO - Running setup.py (path:/tmp/pip-FxniB4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:14:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:14:52 INFO - Running setup.py (path:/tmp/pip-cC935a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:14:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:14:52 INFO - Running setup.py (path:/tmp/pip-d3AAyj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:14:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:14:52 INFO - Running setup.py (path:/tmp/pip-Kd_eWL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:14:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:14:52 INFO - Running setup.py (path:/tmp/pip-Gp8W1u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:14:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:14:52 INFO - Running setup.py (path:/tmp/pip-l9T79Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:14:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:14:52 INFO - Running setup.py (path:/tmp/pip-mvJ_o2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:14:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:14:52 INFO - Running setup.py (path:/tmp/pip-XkE9Oz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:14:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:14:52 INFO - Running setup.py (path:/tmp/pip-dhJkiN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:14:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:14:52 INFO - Running setup.py (path:/tmp/pip-sYM2IQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:14:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:14:53 INFO - Running setup.py (path:/tmp/pip-gAkSOv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:14:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:14:53 INFO - Running setup.py (path:/tmp/pip-ZcnC1T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:14:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:14:53 INFO - Running setup.py (path:/tmp/pip-zs9PAn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:14:53 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:14:53 INFO - Running setup.py install for manifestparser 12:14:53 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:14:53 INFO - Running setup.py install for mozcrash 12:14:53 INFO - Running setup.py install for mozdebug 12:14:53 INFO - Running setup.py install for mozdevice 12:14:53 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:14:53 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:14:53 INFO - Running setup.py install for mozfile 12:14:53 INFO - Running setup.py install for mozhttpd 12:14:53 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:14:53 INFO - Running setup.py install for mozinfo 12:14:53 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:14:53 INFO - Running setup.py install for mozInstall 12:14:54 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:14:54 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:14:54 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:14:54 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:14:54 INFO - Running setup.py install for mozleak 12:14:54 INFO - Running setup.py install for mozlog 12:14:54 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:14:54 INFO - Running setup.py install for moznetwork 12:14:54 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:14:54 INFO - Running setup.py install for mozprocess 12:14:54 INFO - Running setup.py install for mozprofile 12:14:54 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:14:54 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:14:54 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:14:54 INFO - Running setup.py install for mozrunner 12:14:54 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:14:54 INFO - Running setup.py install for mozscreenshot 12:14:54 INFO - Running setup.py install for moztest 12:14:54 INFO - Running setup.py install for mozversion 12:14:54 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:14:54 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:14:54 INFO - Cleaning up... 12:14:54 INFO - Return code: 0 12:14:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:14:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:14:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:14:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:14:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:14:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:14:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:14:54 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 0x7f5511880f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x287a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29455a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d4410>, '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 0x29d5310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29d57a0>, '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': '5cf47e208febbcd81da23b2e0000026f-1460659021.283918-452146743', '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 12:14:54 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 12:14:54 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 12:14:55 INFO - Using env: {'DISPLAY': ':0', 12:14:55 INFO - 'HOME': '/home/cltbld', 12:14:55 INFO - 'LANG': 'en_US.UTF-8', 12:14:55 INFO - 'LANGUAGE': 'en_US:en', 12:14:55 INFO - 'LOGNAME': 'cltbld', 12:14:55 INFO - 'MAIL': '/var/mail/cltbld', 12:14:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:14:55 INFO - 'MOZ_NO_REMOTE': '1', 12:14:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:14:55 INFO - 'NO_EM_RESTART': '1', 12:14:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:14:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:14:55 INFO - 'PWD': '/builds/slave/test', 12:14:55 INFO - 'SHELL': '/bin/bash', 12:14:55 INFO - 'SHLVL': '1', 12:14:55 INFO - 'TERM': 'linux', 12:14:55 INFO - 'TMOUT': '86400', 12:14:55 INFO - 'USER': 'cltbld', 12:14:55 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1460659021.283918-452146743', 12:14:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:14:55 INFO - '_': '/tools/buildbot/bin/python'} 12:14:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:14:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:14:55 INFO - Running setup.py (path:/tmp/pip-ZHBNw9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:14:55 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)) 12:14:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:14:55 INFO - Running setup.py (path:/tmp/pip-BLkINR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:14:55 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)) 12:14:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:14:55 INFO - Running setup.py (path:/tmp/pip-mKBmEJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:14:55 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)) 12:14:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:14:55 INFO - Running setup.py (path:/tmp/pip-nbVYcN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:14:55 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)) 12:14:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:14:55 INFO - Running setup.py (path:/tmp/pip-uvgIi0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:14:55 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)) 12:14:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:14:55 INFO - Running setup.py (path:/tmp/pip-X2R6im-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:14:55 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)) 12:14:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:14:55 INFO - Running setup.py (path:/tmp/pip-HHojJg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:14:55 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)) 12:14:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:14:55 INFO - Running setup.py (path:/tmp/pip-_yYXLC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:14:55 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)) 12:14:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:14:55 INFO - Running setup.py (path:/tmp/pip-SyPAaS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:14:55 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)) 12:14:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:14:55 INFO - Running setup.py (path:/tmp/pip-z15tDe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:14:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 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)) 12:14:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:14:55 INFO - Running setup.py (path:/tmp/pip-OgNCk2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:14:56 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)) 12:14:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:14:56 INFO - Running setup.py (path:/tmp/pip-m5wCSZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:14:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 12:14:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:14:56 INFO - Running setup.py (path:/tmp/pip-fh1tc7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:14:56 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)) 12:14:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:14:56 INFO - Running setup.py (path:/tmp/pip-XHf3J1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:14:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 12:14:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:14:56 INFO - Running setup.py (path:/tmp/pip-wvIHcK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:14:56 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)) 12:14:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:14:56 INFO - Running setup.py (path:/tmp/pip-8cVGCe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:14:56 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)) 12:14:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:14:56 INFO - Running setup.py (path:/tmp/pip-Zu7D9Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:14:56 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)) 12:14:56 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)) 12:14:56 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)) 12:14:56 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)) 12:14:56 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)) 12:14:56 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)) 12:14:56 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:14:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:14:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:14:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:14:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:14:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:14:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:14:58 INFO - Downloading blessings-1.6.tar.gz 12:14:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:14:58 INFO - Installing collected packages: blessings 12:14:58 INFO - Running setup.py install for blessings 12:14:58 INFO - Successfully installed blessings 12:14:58 INFO - Cleaning up... 12:14:58 INFO - Return code: 0 12:14:58 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:14:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:14:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:14:58 INFO - Reading from file tmpfile_stdout 12:14:58 INFO - Current package versions: 12:14:58 INFO - argparse == 1.2.1 12:14:58 INFO - blessings == 1.6 12:14:58 INFO - blobuploader == 1.2.4 12:14:58 INFO - docopt == 0.6.1 12:14:58 INFO - manifestparser == 1.1 12:14:58 INFO - mozInstall == 1.12 12:14:58 INFO - mozcrash == 0.17 12:14:58 INFO - mozdebug == 0.1 12:14:58 INFO - mozdevice == 0.48 12:14:58 INFO - mozfile == 1.2 12:14:58 INFO - mozhttpd == 0.7 12:14:58 INFO - mozinfo == 0.9 12:14:58 INFO - mozleak == 0.1 12:14:58 INFO - mozlog == 3.1 12:14:58 INFO - moznetwork == 0.27 12:14:58 INFO - mozprocess == 0.22 12:14:58 INFO - mozprofile == 0.28 12:14:58 INFO - mozrunner == 6.11 12:14:58 INFO - mozscreenshot == 0.1 12:14:58 INFO - mozsystemmonitor == 0.0 12:14:58 INFO - moztest == 0.7 12:14:58 INFO - mozversion == 1.4 12:14:58 INFO - psutil == 3.1.1 12:14:58 INFO - requests == 1.2.3 12:14:58 INFO - wsgiref == 0.1.2 12:14:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:14:58 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')]} 12:14:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:14:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:14:58 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')]} 12:14:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:14:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:14:58 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 0x7f5511880f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x287a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29455a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d4410>, '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 0x29d5310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29d57a0>, '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': '5cf47e208febbcd81da23b2e0000026f-1460659021.283918-452146743', '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 12:14:58 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 12:14:58 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 12:14:58 INFO - Using env: {'DISPLAY': ':0', 12:14:58 INFO - 'HOME': '/home/cltbld', 12:14:58 INFO - 'LANG': 'en_US.UTF-8', 12:14:58 INFO - 'LANGUAGE': 'en_US:en', 12:14:58 INFO - 'LOGNAME': 'cltbld', 12:14:58 INFO - 'MAIL': '/var/mail/cltbld', 12:14:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:14:58 INFO - 'MOZ_NO_REMOTE': '1', 12:14:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:14:58 INFO - 'NO_EM_RESTART': '1', 12:14:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:14:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:14:58 INFO - 'PWD': '/builds/slave/test', 12:14:58 INFO - 'SHELL': '/bin/bash', 12:14:58 INFO - 'SHLVL': '1', 12:14:58 INFO - 'TERM': 'linux', 12:14:58 INFO - 'TMOUT': '86400', 12:14:58 INFO - 'USER': 'cltbld', 12:14:58 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1460659021.283918-452146743', 12:14:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:14:58 INFO - '_': '/tools/buildbot/bin/python'} 12:14:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:14:58 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)) 12:14:58 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)) 12:14:58 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)) 12:14:58 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)) 12:14:58 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)) 12:14:58 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)) 12:14:58 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)) 12:14:58 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)) 12:14:58 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)) 12:14:58 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)) 12:14:58 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)) 12:14:58 INFO - Cleaning up... 12:14:59 INFO - Return code: 0 12:14:59 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:14:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:14:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:14:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:14:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:14:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:14:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:14:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5511880f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x287a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29455a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d4410>, '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 0x29d5310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29d57a0>, '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': '5cf47e208febbcd81da23b2e0000026f-1460659021.283918-452146743', '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 12:14:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 12:14:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 12:14:59 INFO - Using env: {'DISPLAY': ':0', 12:14:59 INFO - 'HOME': '/home/cltbld', 12:14:59 INFO - 'LANG': 'en_US.UTF-8', 12:14:59 INFO - 'LANGUAGE': 'en_US:en', 12:14:59 INFO - 'LOGNAME': 'cltbld', 12:14:59 INFO - 'MAIL': '/var/mail/cltbld', 12:14:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:14:59 INFO - 'MOZ_NO_REMOTE': '1', 12:14:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:14:59 INFO - 'NO_EM_RESTART': '1', 12:14:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:14:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:14:59 INFO - 'PWD': '/builds/slave/test', 12:14:59 INFO - 'SHELL': '/bin/bash', 12:14:59 INFO - 'SHLVL': '1', 12:14:59 INFO - 'TERM': 'linux', 12:14:59 INFO - 'TMOUT': '86400', 12:14:59 INFO - 'USER': 'cltbld', 12:14:59 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1460659021.283918-452146743', 12:14:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:14:59 INFO - '_': '/tools/buildbot/bin/python'} 12:14:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:14:59 INFO - Downloading/unpacking jsonschema 12:14:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:14:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:14:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:14:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:14:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:14:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:15:01 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:15:01 INFO - Downloading/unpacking functools32 (from jsonschema) 12:15:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:15:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:15:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:15:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:15:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:15:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:15:01 INFO - Downloading functools32-3.2.3-2.tar.gz 12:15:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:15:01 INFO - warning: no files found matching '*.txt' 12:15:01 INFO - no previously-included directories found matching 'build' 12:15:01 INFO - no previously-included directories found matching 'dist' 12:15:01 INFO - no previously-included directories found matching '.git*' 12:15:01 INFO - Installing collected packages: jsonschema, functools32 12:15:01 INFO - Running setup.py install for functools32 12:15:01 INFO - warning: no files found matching '*.txt' 12:15:01 INFO - no previously-included directories found matching 'build' 12:15:01 INFO - no previously-included directories found matching 'dist' 12:15:01 INFO - no previously-included directories found matching '.git*' 12:15:01 INFO - Successfully installed jsonschema functools32 12:15:01 INFO - Cleaning up... 12:15:01 INFO - Return code: 0 12:15:01 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 12:15:01 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')]} 12:15:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:15:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:15:01 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')]} 12:15:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:15:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:15:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5511880f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x287a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29455a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d4410>, '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 0x29d5310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29d57a0>, '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': '5cf47e208febbcd81da23b2e0000026f-1460659021.283918-452146743', '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 12:15:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 12:15:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 12:15:01 INFO - Using env: {'DISPLAY': ':0', 12:15:01 INFO - 'HOME': '/home/cltbld', 12:15:01 INFO - 'LANG': 'en_US.UTF-8', 12:15:01 INFO - 'LANGUAGE': 'en_US:en', 12:15:01 INFO - 'LOGNAME': 'cltbld', 12:15:01 INFO - 'MAIL': '/var/mail/cltbld', 12:15:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:15:01 INFO - 'MOZ_NO_REMOTE': '1', 12:15:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:15:01 INFO - 'NO_EM_RESTART': '1', 12:15:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:15:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:15:01 INFO - 'PWD': '/builds/slave/test', 12:15:01 INFO - 'SHELL': '/bin/bash', 12:15:01 INFO - 'SHLVL': '1', 12:15:01 INFO - 'TERM': 'linux', 12:15:01 INFO - 'TMOUT': '86400', 12:15:01 INFO - 'USER': 'cltbld', 12:15:01 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1460659021.283918-452146743', 12:15:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:15:01 INFO - '_': '/tools/buildbot/bin/python'} 12:15:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:15:01 INFO - Downloading/unpacking flake8 12:15:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:15:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:15:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:15:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:15:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:15:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:15:03 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 12:15:03 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 12:15:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:15:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:15:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:15:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:15:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:15:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:15:03 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 12:15:03 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 12:15:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:15:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:15:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:15:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:15:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:15:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:15:04 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 12:15:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:15:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:15:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:15:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:15:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:15:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:15:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 12:15:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:15:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:15:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:15:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:15:04 INFO - no previously-included directories found matching 'docs/_build' 12:15:04 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 12:15:04 INFO - Running setup.py install for pep8 12:15:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:15:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:15:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:15:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:15:04 INFO - no previously-included directories found matching 'docs/_build' 12:15:04 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 12:15:04 INFO - Successfully installed flake8 mccabe pyflakes pep8 12:15:04 INFO - Cleaning up... 12:15:04 INFO - Return code: 0 12:15:04 INFO - Running post-action listener: _resource_record_post_action 12:15:04 INFO - Running post-action listener: _start_resource_monitoring 12:15:04 INFO - Starting resource monitoring. 12:15:04 INFO - ##### 12:15:04 INFO - ##### Running install step. 12:15:04 INFO - ##### 12:15:04 INFO - Running pre-action listener: _resource_record_pre_action 12:15:04 INFO - Running main action method: install 12:15:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:15:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:15:04 INFO - Reading from file tmpfile_stdout 12:15:04 INFO - Detecting whether we're running mozinstall >=1.0... 12:15:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:15:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:15:04 INFO - Reading from file tmpfile_stdout 12:15:04 INFO - Output received: 12:15:04 INFO - Usage: mozinstall [options] installer 12:15:04 INFO - Options: 12:15:04 INFO - -h, --help show this help message and exit 12:15:04 INFO - -d DEST, --destination=DEST 12:15:04 INFO - Directory to install application into. [default: 12:15:04 INFO - "/builds/slave/test"] 12:15:04 INFO - --app=APP Application being installed. [default: firefox] 12:15:04 INFO - mkdir: /builds/slave/test/build/application 12:15:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 12:15:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 12:15:20 INFO - Reading from file tmpfile_stdout 12:15:20 INFO - Output received: 12:15:20 INFO - /builds/slave/test/build/application/firefox/firefox 12:15:20 INFO - Running post-action listener: _resource_record_post_action 12:15:20 INFO - ##### 12:15:20 INFO - ##### Running run-tests step. 12:15:20 INFO - ##### 12:15:20 INFO - Running pre-action listener: _resource_record_pre_action 12:15:20 INFO - Running main action method: run_tests 12:15:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:15:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:15:20 INFO - Python 2.7.3 12:15:20 INFO - Return code: 0 12:15:20 INFO - grabbing minidump binary from tooltool 12:15:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:15:20 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: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d4410>, '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 0x29d5310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29d57a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:15:20 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 12:15:20 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 12:15:20 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:15:20 INFO - Return code: 0 12:15:20 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 12:15:20 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:15:20 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:15:20 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 12:15:20 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:15:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 12:15:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 12:15:21 INFO - Return code: 0 12:15:21 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/O13gFoQRTV-lV4uQZhnW3A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-011', '--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 12:15:21 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/O13gFoQRTV-lV4uQZhnW3A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-011 --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 12:15:21 INFO - Using env: {'DISPLAY': ':0', 12:15:21 INFO - 'HOME': '/home/cltbld', 12:15:21 INFO - 'LANG': 'en_US.UTF-8', 12:15:21 INFO - 'LANGUAGE': 'en_US:en', 12:15:21 INFO - 'LOGNAME': 'cltbld', 12:15:21 INFO - 'MAIL': '/var/mail/cltbld', 12:15:21 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:15:21 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:15:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:15:21 INFO - 'MOZ_NO_REMOTE': '1', 12:15:21 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:15:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:15:21 INFO - 'NO_EM_RESTART': '1', 12:15:21 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:15:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:15:21 INFO - 'PWD': '/builds/slave/test', 12:15:21 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:15:21 INFO - 'SHELL': '/bin/bash', 12:15:21 INFO - 'SHLVL': '1', 12:15:21 INFO - 'TERM': 'linux', 12:15:21 INFO - 'TMOUT': '86400', 12:15:21 INFO - 'USER': 'cltbld', 12:15:21 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1460659021.283918-452146743', 12:15:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:15:21 INFO - '_': '/tools/buildbot/bin/python'} 12:15:21 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/O13gFoQRTV-lV4uQZhnW3A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-011', '--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 12:15:21 INFO - mozversion application_buildid: 20160414115241 12:15:21 INFO - mozversion application_changeset: d0b6d063cf4981b3c893f511e84f6aac3a96b2f9 12:15:21 INFO - mozversion application_display_name: Nightly 12:15:21 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:15:21 INFO - mozversion application_name: Firefox 12:15:21 INFO - mozversion application_remotingname: firefox 12:15:21 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 12:15:21 INFO - mozversion application_vendor: Mozilla 12:15:21 INFO - mozversion application_version: 48.0a1 12:15:21 INFO - mozversion platform_buildid: 20160414115241 12:15:21 INFO - mozversion platform_changeset: d0b6d063cf4981b3c893f511e84f6aac3a96b2f9 12:15:21 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 12:15:21 INFO - mozversion platform_version: 48.0a1 12:15:21 INFO - using testdate: 1460661321 12:15:21 INFO - actual date: 1460661321 12:15:21 INFO - starting webserver on 'localhost:46611' 12:15:21 INFO - SUITE-START | Running 2 tests 12:15:21 INFO - TEST-START | dromaeo_css 12:15:21 INFO - operating with platform_type : linux_ 12:15:21 INFO - Initialising browser for dromaeo_css test... 12:15:22 INFO - TEST-INFO | started process 22474 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpv4s29L/profile http://localhost:46611/getInfo.html) 12:15:27 INFO - PROCESS | 22474 | __metrics Screen width/height:1600/1200 12:15:27 INFO - PROCESS | 22474 | colorDepth:24 12:15:27 INFO - PROCESS | 22474 | Browser inner width/height: 1024/697 12:15:27 INFO - PROCESS | 22474 | __metrics 12:15:29 ERROR - PROCESS | 22474 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 12:15:30 INFO - TEST-INFO | 22474: exit 0 12:15:30 INFO - Browser initialized. 12:15:30 INFO - Running cycle 1/1 for dromaeo_css test... 12:15:30 INFO - TEST-INFO | started process 22555 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpv4s29L/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:15:42 INFO - PROCESS | 22555 | RSS: Main: 154988544 12:15:42 INFO - PROCESS | 22555 | 12:16:33 INFO - PROCESS | 22555 | 1460661393054 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] 12:18:45 INFO - PROCESS | 22555 | Cycle 1(1): loaded http://localhost:46611/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46611/tests/dromaeo/cssquery-ext.html) 12:18:47 INFO - PROCESS | 22555 | RSS: Main: 280686592 12:18:47 INFO - PROCESS | 22555 | 12:21:49 INFO - PROCESS | 22555 | Cycle 1(1): loaded http://localhost:46611/tests/dromaeo/cssquery-ext.html (next: http://localhost:46611/tests/dromaeo/cssquery-jquery.html) 12:21:50 INFO - PROCESS | 22555 | RSS: Main: 237858816 12:21:50 INFO - PROCESS | 22555 | 12:24:52 INFO - PROCESS | 22555 | Cycle 1(1): loaded http://localhost:46611/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46611/tests/dromaeo/cssquery-mootools.html) 12:24:52 INFO - PROCESS | 22555 | RSS: Main: 235237376 12:24:52 INFO - PROCESS | 22555 | 12:27:54 INFO - PROCESS | 22555 | Cycle 1(1): loaded http://localhost:46611/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46611/tests/dromaeo/cssquery-prototype.html) 12:27:55 INFO - PROCESS | 22555 | RSS: Main: 237961216 12:27:55 INFO - PROCESS | 22555 | 12:30:58 INFO - PROCESS | 22555 | Cycle 1(1): loaded http://localhost:46611/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46611/tests/dromaeo/cssquery-yui.html) 12:30:59 INFO - PROCESS | 22555 | RSS: Main: 215736320 12:30:59 INFO - PROCESS | 22555 | 12:34:01 INFO - PROCESS | 22555 | Cycle 1(1): loaded http://localhost:46611/tests/dromaeo/cssquery-yui.html (next: http://localhost:46611/tests/dromaeo/cssquery-dojo.html) 12:34:01 INFO - PROCESS | 22555 | RSS: Main: 258183168 12:34:01 INFO - PROCESS | 22555 | 12:34:01 INFO - PROCESS | 22555 | __start_tp_report 12:34:01 INFO - PROCESS | 22555 | _x_x_mozilla_page_load 12:34:01 INFO - PROCESS | 22555 | _x_x_mozilla_page_load_details 12:34:01 INFO - PROCESS | 22555 | |i|pagename|runs| 12:34:01 INFO - PROCESS | 22555 | |0;dojo.html;2636.8813403396853;2669.9186829334126;2694.838309701418;2718.347596576822;2733.617293578899;4622.815087396509;4669.0428462165255;4688.765561721917;4688.812447502096;4734.644901632379;4586.243269860477;4631.652626053043;4659.88350291242;4672.392588963438;4679.110968915904;4242.109157077018;4261.722988005785;4265.104328091104;4284.036091879318;4317.11499142675;4298.548652391485;4347.586979236968;4397.890052748691;4423.447069116361;4431.911361772763;4204.957950420488;4295.076558539898;4300.22595932732;4327.459067616548;4372.562743725618;4209.536950935395;4211.43145675333;4214.620684138442;4215.494140703136;4225.746455212667;4201.117765269297;4202.138561594897;4205.768682722449;4206.684498662582;4217.97891010546;4569.611583015448;4571.794269257892;4660.720356778605;4676;4694.08465349257;4939.357883475125;4940.110780059588;4953.1332016896895;4956.504349565051;4992.950070499285;4957.752112394402;4961.875953101166;4964.975175124101;4967.031428871372;4981.053599816023;4486.887827804331;4648.6745927785405;4673.065386922561;4706.152892479318;4719.504452032487;5075.213341932006;5076.314697515862;5079.619028572872;5086.593072554187;5144.511271429283;4849.151398505318;4878.902421951541;4883.194272944925;4890.6332025097545;4943.431505376856;4974.527419895104;5007.298978143063;5028.044671512474;5072.746362681851;5077.162268225775;4923.975380123076;4928.186849169919;4933.161362568372;4966.180580204225;4984.526469985346;4815.15734746418;4847.733374664357;4922.532359425849;4926.655134140576;4964.751762411937;4244.193603215379;4245.596668316505;4255.148970205972;4270.359446083113;4289.120730250291;3708.2212735325884;3722.8883133506038;3726.4782930389765;3757.267332870119;3771.7925514096987;4294.806733696991;4368.148211098805;4369;4381.518033016366;4429.68992170545;4942.802287908444;4956.776945037482;4992.8002879885125;5022.321986531844;5054.671446355975;4339.82640694375;4369.2790689536505;4370.781460926941;4371.0602220522105;4413.051193993307;4410.69125161242;4518.593326600556;4521.638268938477;4523.208438523311;4560.84037058708;4735.2186889163595;4762.333273341805;4787.61699064067;4829.806807727651;4835.032993401404;5006;5007.974960125176;5022.422421421437;5024.271480635361;5077;4576.084783043338;4701.764911754467;4712.646551508582;4712.905741885212;4761.095391875532;4863.708177509361;4872.074305881871;4873.439554451284;4876.902461950812;4921.188003979303;4977.800887964441;4987.576056035277;4993.051320249141;4994.350734404504;5024.070546948826;4652.255639097728;4843.854684359334;4844.588210002048;4900.2894580286375;4903.901921961612;4878.536539028786;4896.461389247252;4897.804087836446;4919.286703428054;4950.6782059166035;4812.807487700453;4829.6860704054125;4830.178869592108;4833.830815921426;4881.536254055859;4811.759412029454;4879.024195160911;4879.731614761222;4884.78018489176;4916.508349165055;4752.144613969519;4770.928436073392;4787.736674482937;4793.520647935178;4793.760311984317 12:34:01 INFO - PROCESS | 22555 | |1;ext.html;552.8175702018332;595.8063629320469;601.6811090122235;606.6360183889664;620.3083561828561;32440.351192976155;33615.9915202544;33697.15757106068;33707;33714.32571348571;36082.63917360826;36487.63512364875;36597.71907983221;36621.63378366215;36871.262574748485;7238.493305468619;7549.433792465573;7736.806579835521;7737.961310193441;7740.574268415235;9554.140127388533;9990.50047497626;10034.147097496685;10038.44404117363;10050.045245701647;9649.324547281693;9819.803603927918;9821.705348839547;9825.213982881389;9835.65575204868;7423.40612750984;9561.091696288842;9576.856347154799;9791.608335666564;10030.49847507629;9563.760905977406;9662.90337096627;9699.51502424876;9701.417914925127;9709.417434953926;33709.83145084284;34142.6585734142;34217.31565368679;34274;34275.14312142217;3003.7296643302207;3100.875964961399;3174.888878889251;3187.474066778979;3501;28224.717752822413;28325.716742832516;29062.854685726437;29232.41535169306;29761;3314.6022477302636;3478.3738926993133;3508.0177550285707;3508.9297764181915;3556.6443355664487;201723;202805;204560;205152;206207;32741.18147046343;50483;51597;51626.74186629043;51647.225291620656;31558.684413156032;31568.368632627218;31633.84183079116;31718.524222136686;31746.68253317437;13233.73532529344;13453.125546839425;13462.528811491551;13467.86532134666;13475.932620337031;9474.573644186028;11079.390633515233;11116.277441966246;11345;11392.544298227978;7891.802704932308;7910;7949.125596184415;7979.9601001994615;7990.12108668046;3161.9051428457183;3233.9029829105166;3248.577684900995;3251.9349613007607;3271.7382609391193;819.7090033038305;907.5280853955906;944.8960614332418;1018.974525636865;1079.578964203961;26896.413944660715;26999;27113.45773084567;27293.181204563894;27530.44939101207;959.2230293462318;961;988.8417853143462;1011.2920955331298;1101.4878081692052;14715.852841471662;14874.553763387115;14884;15117.319720612599;15208.46770363032;327515;332427;332613;332822;333121;47086;47664.23357664206;47700.284495732594;47729.522704773204;47753;1042.499600191897;1147.701597584634;1219.621917205669;1226.0314351662266;1330.8269924909894;24777.504449911263;25219.495610087328;26203.724534433197;27217.76508589449;27744.167674969784;36774.44838327481;37841.81079094697;38079.428808568446;38083.04792380213;38141.23717525578;215439;216088;216165;216851;217725;22421.77578224197;24827;24913;25328.493430131664;25610.10364637229;35276.118097046754;35513.46729799107;35560.64439355573;36096.81951590225;36403;30523.694763052084;30946.84526577353;31153.8442307787;31336;32048.67951320457;33135.83432082824;33139.33721325608;33342.666573333954;33515.83242083774;33731.83134084314;33217.501737473474;33343.49984750279;33788.66211337855;33872.66127338695;34079.318413632085;29122.854385727936;30323.241918952204;30378.84810575933;30562.235944100685;30569.54145687772;23435.882820585786;23437.179698710464;23444;23761.287161385186;23804.285871423886 12:34:01 INFO - PROCESS | 22555 | |2;jquery.html;380.16397673356755;385.2872186455058;387.9786611736355;392.48976330769995;398.80458575298115;15517.602160287763;16692.49922502324;16809.24358403872;16870.325186992504;16927.492175234747;15649.687006259868;16222.83777162228;16345.754813677804;16348.673026539493;16359.100249486273;5055.974720126404;5195.714235717034;5227.60792940531;5245.344331958505;5245.8950820983555;3602.477640742091;5452.645578037414;6006.369331220225;6013.969930150343;6015.067664511986;5864.149698293745;5917.852053698649;5921.378255283198;5936.762529498815;5952.4047595240345;5771.797987070453;5926.348101708809;5942.138389933435;5947.762089516415;5957;3342.197872510604;4894.657373983822;5204.167333226704;5235.528802407802;5246.921296180561;19950.70073948892;20030.857919620554;20605.587888242302;21128.471788205265;21681.34955951324;1957.4910523263911;2049.98975005124;2062.9174833006664;2122.639151344275;2142.7964343387353;12913.662599109288;13228.206307621573;13248.106344121448;13418.12970261562;13628.318584070856;1514.6289159156076;1651.3972400074006;1741.6255505066472;1757.5957529768098;1813.5103522049105;64694.35305646931;67710.85903403026;69129.65435172792;69245.65377173082;69747.95378069383;9880.258980576486;10057;10275.332103413255;10476.109530689977;10715.624953126604;14153.43386264538;14206.644833879029;14231.43074277038;14273.500427484989;14273.643158920902;7274.090738657668;7351.338379545759;7523.548587084792;7693.730719424793;7710.96144519285;7441.627918604048;7490.550566966;7547.962260188664;7628.313451789366;7645.770626881203;6060.363661815534;6208.937910620836;6304.968475157595;6307.716152773136;6355.586886852339;1642.1707037945762;1764.7264673975553;1848.935287264966;1856.0070362356075;1860.7394964704952;873.8427083125099;877.8463768840427;897.8294124116397;941.0683423410774;991.2070343724992;17957;18115;18185.7272140918;18263.17815698297;18311.705792325552;869.2741560796679;879.846026945282;910.7040211931148;919.6382954449588;994.7264502261792;9976.102150806462;10174.949125254327;10337.483125843677;10352.120069794151;10405.635802746867;287956;293855;294311.52844235644;294756;378728;65726.04232809535;72494;80227.19772802314;85283;86663.56668216619;980.1913421427352;1002.2633364477249;1006.431366278036;1028.3726926574784;1029.1509504658686;14910.701785964437;15191;15517.146556939026;15525.45660901863;15708.450204242796;35901.82049089738;36231.456528151575;36710.63289367179;36966.445503316936;37364.43953340757;48220.7588962053;51116.74441627768;51363;51548.48451515437;51595;7413.703451861865;7521.0974683038385;7617.238276172338;7699.538027718355;7779.92220077792;8358.623861926106;11195.664130076111;11323.433828308387;11749;11892.286462812259;9920.007999200023;10144.746381340525;10406.531706073396;10464.895351046393;10616;9527.237820974444;10082.747931301776;10249.33379330341;10419.166466682798;10589.311694739818;10210.897891020995;10416.843747343948;10418.426986515815;10663.840042399526;10784.89215107839;7517.135529414188;7529.397648188241;7650.737628291269;7663.501872378278;7671.1561728208735;10026.398416095057;10039.799204016024;10146.289759716748;10149.64476243328;10345.431001295 12:34:01 INFO - PROCESS | 22555 | |3;mootools.html;1311.9504396482812;1381.4267079162146;1432.9498467553635;1530.6862093270881;1780.5548612846787;6778.254392016875;7613.809654758634;7792.064952205729;7824.021997250344;7836.882446763303;7618.047744031996;7769.300762931335;7775;7775.766726998185;7783.299503044725;1817.182267979408;2158.2877650375417;2209.845310828243;2229.487217939875;2238.6865838782583;2272.8977196026217;2294.357579877637;2294.4608017115966;2294.827887908405;2295.494991101963;2182.2034957240653;2216.833737469688;2218.3566765638025;2219.4673278413225;2224.3327001899447;1883.4537983984628;2163.4375062483787;2210.557888422306;2219.655953327237;2223.7442694090223;2131.776163502841;2141.871487710727;2154.5906277807167;2154.6983422320886;2163.2212403534872;7625.275598818103;7672.0409948756405;7688.269614386624;7699.576523291216;7735.265149810759;4329.718568293051;4461.196984542781;4487.080148569568;4506.571875671806;4507.3689683444345;3014.231371000381;3025.0471101603143;3085.568020477135;3105.4254962831947;3123.3597112591865;1011.5144730529314;1054.9630762923261;1058.5395353021383;1060.2154405739698;1066.3441983180367;10044;10311.226658000605;10371.222158338154;10397.480125993745;10809.729756756065;4035.616616421435;4117.773522456234;4224.007358270804;4260.893477663083;4264.232438161099;8579.099194584478;8611.095834937367;8622.827543449095;8627.180417860292;8627.95686021566;3970.3845903884944;4463.754493502824;4468.50846406895;4472.530384309665;4475.977620111878;4144.129732756095;4246.299360605527;4257.829686812493;4275.422817919603;4292.098659281523;3469.4275444551367;3471.5486986691567;3527.153483164022;3568.892933212008;3612.512310838056;1070.1813112968584;1086.32104934416;1086.473060565625;1086.6468397770757;1096.276457538021;797.9082405523322;912.1744820937063;912.9041450647719;926.6478738079621;946.7775072857872;5438.0121543816;5706.71466426677;5713.085906254979;5744.770209191669;5764.942350576441;926.1340646495548;938.3572253006712;943.0852073488705;948.6679662118204;969.1471505075489;3759.379702349082;3850.4994350734223;3973.6225058619384;3980.7611543307494;3984.1035766952205;9222;9551.856722149174;9641.807163856824;9648.131668149901;9664.806703866025;9710.368826026426;9710.563024663907;9799.657012004545;9844.556994935101;9855.605775768889;7274.818129546804;7320.401257553598;7377.077865266841;7426.108866936002;7507.7747667568965;5434.782608695766;5499.5325397340075;5576.191452239484;5577.3028371453565;5736.311642602915;8939.865902011605;9007.774805629911;9051.185393314634;9103.544822758968;9199.54002299869;8661.653533858575;8868.77828054278;8884;8887.466751994902;8980.685676001309;6064.211652485149;6224.875502490016;6231.813045608639;6637.6349300788925;6798.932010680028;7139.607321597362;7400.962995184989;7403.407727381904;7428.6285685716575;7430.108386993596;6467.741290348334;6679.56582822115;6718.6976586054725;6830.59016459014;6883.3116688330765;6753.257141714309;6777.8983315249325;6782.355676210752;6875.931240687729;6899.931000689929;6503.544751867324;6525.380088891738;6591.274959754519;6601.768938087144;6635.6350400728425;4853.951460485491;4880.243562247857;4951.554360107608;5012.373453318335;5039.496050394931;4637.350770892145;4652.604528615106;4676.602488788355;4704.5765881070865;4774.140654682191 12:34:01 INFO - PROCESS | 22555 | |4;prototype.html;321.81174013202275;322.1302483295103;326.35056238086213;330.33767296570403;332.46971081125594;5153.149730294497;5196.974015129924;5203.167493201088;5208.713520756357;5229.398619158798;5126.769295381708;5149.30484384608;5163;5165.767540460679;5174.586033117351;3810.2189051244427;3878.825452854628;4070.2266569351877;4072.3484242521204;4080.449139366192;4043.2722110020186;4043.9797801010955;4050.7164498485117;4053.756774593519;4062.939055914164;3809;4008.8797336079965;4015.9397609035886;4019.5980401959864;4040;3895;4021.235965166609;4041.1715598302276;4048.858289959867;4050.534188568323;3571.6964058055096;3583.301256255031;3591.8024508652015;3592.3533763922483;3593.7484376093685;4899.681520701143;4901.607871370282;4916.434610019822;4934.6052315815;4967.900641987176;4552.180607490651;4598.379218805452;4640.767961601907;4652.74409907455;4660.9237902984205;5374.462553744634;5393.838184854421;5394.136938089887;5418.078926582491;5430.56555475561;3918.314294998364;3919.7844118573466;3938.4879965604573;3939.1530820873363;3942.2706799242233;5517.613767036309;5672.376038635788;5676.971615141939;5716.228309178249;5724.513416359614;3995.6403923647013;4008.5390180129075;4009.498812648419;4036.979815100906;4041.515018197835;4096.283150448659;4096.508418989681;4098.938515922264;4103.425520427142;4113.465249517543;4369.148016136886;4612.446506419251;4627.663030169742;4628.814847406134;4647.604953578916;5427.9185812212845;5434.266374039533;5440.455954404528;5459.617826752169;5476.972615136899;1411.792917055923;1436.0665567381286;1438.992805035968;1439.7480440922798;1443.444273954535;926.5228407370209;976.8485884687884;994.5176589354157;1001.2840818814583;1017.1659239423601;4783.425988881357;4806.110869489085;4813;4813.711177329372;4833.564979151894;5576.6096373254295;5591.8602034948635;5592.328920529481;5598.888022239533;5601.459598610333;4670.392848929685;4800.73595952219;4819.5782244238035;4820.156472617278;4821.108095002436;2940.3678209185127;2970.8960186393374;2980.940381192364;2984.463001554201;2985.641722993255;5252.711100889488;5255.684658920477;5257.447967963385;5272.288241087481;5287.841364759063;5551.694656793834;5735.942640573624;5812.82561523155;5826.883462330815;5840.532757379399;5315.123004704258;5334.093204155303;5349.438308977501;5366.651167674088;5382.407935127211;5337.519623233928;5652.519535839335;5658.292713410824;5668.886622267614;5674.914876276776;5580.86047848807;5604.719764011702;5609.80365687199;5611.8877622448135;5633.746481408264;5360.383555891122;5368.382635996911;5370.62405631602;5383.353997520323;5385.542228910586;3688.981555092207;3909.651170346226;3937.822797974041;3949.348357520977;3963.821628026688;5595.07681232592;5604.663720176803;5609.59760059985;5611.775528978795;5612.803551875828;5394.78420863161;5405.5135037846785;5420.132778755538;5434.184872269191;5437.211604317431;5334.359876814807;5342;5403.189521571796;5423.810166644149;5433.429489903661;5088.821891233789;5289.7355132244;5317.282166907418;5323.653962492425;5325.893482130413;5295.7087360195555;5481.972590137024;5495.313085864267;5518.80684176068;5522.116461366162;5363.383210930793;5373.596980226421;5374.543163830962;5380.3274590676165;5385.973070134781 12:34:01 INFO - PROCESS | 22555 | |5;yui.html;740.4705635470638;771.8726410142327;781.2851241114381;784.1726978038167;784.7175016993881;12304.38478076096;12535.498580056787;12618.053645976543;12657.11400201984;12659.873401265984;12839.48642054319;12904;12929.288889111118;12973.740525189514;12997.610071697864;639.2680380963793;814.7759366174305;820.1306614988102;820.3027426687328;820.9055958564752;779.6881247501017;811.7280710961835;814.633414963266;815.4740192575786;815.6451943404609;845.8815765792793;846.1622993236713;849.9830003399959;850.1838235294125;850.7320194138827;669.9397054265091;813.1827513349047;845.3364109174269;845.873119032147;846.1284876577135;614.6127939398195;614.8278482024996;615.1388056720582;615.4676205082616;615.6860001399274;12090.09324300681;12127.878721212852;12176.634700958986;12206.450709718085;12219.694507637292;11997.820032699516;12481.687957801038;12568.74862502754;12796.680082997906;13021.609351719464;10134;10168.36618406318;10243.94878025605;10428.426436545988;10444.68665940023;3264.5266436366833;3265.918352041218;3306.322203948185;3323.0363194673514;3404.0298514923375;49653.50346496525;49747.25379119316;50088.499115009115;50273;50432.243516347284;9880;9916.603335866628;9916.801663966824;10012.199024078056;10051.547680354402;16751.32994680199;16773.7483937741;16796.832031679773;16804.6639067218;16824.579385515215;6704.698288577026;6739.326067393222;6799.5920244785475;6840.213375461885;6976.093107895941;3742.812859357076;3787.5454945406727;3821.4840996465678;3862.2854771867296;3983.940240896331;2903.535434330497;3007.3684526249294;3010.3076292452856;3015.1105423900003;3017.260771111092;491.4053994666422;504.9065922804293;511.69298420947877;518.4918779596017;519.2885746527281;480.3587211073256;539.4255118298998;585.689584520205;610.1732152932801;614.1586027142843;7188.964055179691;7584.924150758422;7637.42719296055;7971.72098976533;7987.8402431951035;607.4108115128407;638.4158494977137;639.8240483866881;646.867392184601;650.0314531348257;3586.103474131467;3685.9262814743556;3689.963100368962;3705.94441083384;3711.628837116321;49610;49710;52671.47328526666;53515.464845351824;53712;44581.554184458386;44687.10625787466;44750.88122796956;44968.55031449644;45394.77302613532;42428.57571424246;42701.57298427038;42729;42953.14093718108;43345.34981975273;7197.928020719935;7271.127464704269;7318.817029574303;7337.70649174027;7486.064241969754;26847.865760671073;27126.1862144136;27449.90200391962;27521.86239068792;27616.585751213344;34692.826535867156;35448;37786;38187.42718859164;38344;9495.287853410884;9721.368111072758;10582.894171058191;10592.311499752492;10746.570137194425;11898.167128300936;11906.40467976615;11974.161808673658;12037.939810300892;12651.93674031624;8085.8787118192095;9892.554835032584;10518.842217366593;10876.564937402416;11064.834027489755;10811.837822432828;11003.17476189305;11060.723481913017;11119.666410007712;11147.331160130418;9504.95247523758;9565.808683826424;9782.80434391294;10028.498575071071;10397.740056498647;9330.160285574331;9413.529323533932;9553.331266811256;9570.282228832726;9583.952080239555;8915.821683566162;9154.862677059717;9738.610455581698;9754.658586949423;9817.233928677599 12:34:01 INFO - PROCESS | 22555 | __end_tp_report 12:34:01 INFO - PROCESS | 22555 | __start_cc_report 12:34:01 INFO - PROCESS | 22555 | _x_x_mozilla_cycle_collect,1215 12:34:01 INFO - PROCESS | 22555 | __end_cc_report 12:34:01 INFO - PROCESS | 22555 | __startTimestamp1460662441818__endTimestamp 12:34:01 INFO - PROCESS | 22555 | 12:34:01 INFO - PROCESS | 22555 | ------- Summary: start ------- 12:34:01 INFO - PROCESS | 22555 | Number of tests: 6 12:34:01 INFO - PROCESS | 22555 | 12:34:01 INFO - PROCESS | 22555 | [#0] dojo.html Cycles:165 Average:4615.47 Median:4761.10 stddev:466.35 (9.8%) stddev-sans-first:441.20 12:34:01 INFO - PROCESS | 22555 | Values: 2636.9 2669.9 2694.8 2718.3 2733.6 4622.8 4669.0 4688.8 4688.8 4734.6 4586.2 4631.7 4659.9 4672.4 4679.1 4242.1 4261.7 4265.1 4284.0 4317.1 4298.5 4347.6 4397.9 4423.4 4431.9 4205.0 4295.1 4300.2 4327.5 4372.6 4209.5 4211.4 4214.6 4215.5 4225.7 4201.1 4202.1 4205.8 4206.7 4218.0 4569.6 4571.8 4660.7 4676.0 4694.1 4939.4 4940.1 4953.1 4956.5 4993.0 4957.8 4961.9 4965.0 4967.0 4981.1 4486.9 4648.7 4673.1 4706.2 4719.5 5075.2 5076.3 5079.6 5086.6 5144.5 4849.2 4878.9 4883.2 4890.6 4943.4 4974.5 5007.3 5028.0 5072.7 5077.2 4924.0 4928.2 4933.2 4966.2 4984.5 4815.2 4847.7 4922.5 4926.7 4964.8 4244.2 4245.6 4255.1 4270.4 4289.1 3708.2 3722.9 3726.5 3757.3 3771.8 4294.8 4368.1 4369.0 4381.5 4429.7 4942.8 4956.8 4992.8 5022.3 5054.7 4339.8 4369.3 4370.8 4371.1 4413.1 4410.7 4518.6 4521.6 4523.2 4560.8 4735.2 4762.3 4787.6 4829.8 4835.0 5006.0 5008.0 5022.4 5024.3 5077.0 4576.1 4701.8 4712.6 4712.9 4761.1 4863.7 4872.1 4873.4 4876.9 4921.2 4977.8 4987.6 4993.1 4994.4 5024.1 4652.3 4843.9 4844.6 4900.3 4903.9 4878.5 4896.5 4897.8 4919.3 4950.7 4812.8 4829.7 4830.2 4833.8 4881.5 4811.8 4879.0 4879.7 4884.8 4916.5 4752.1 4770.9 4787.7 4793.5 4793.8 12:34:01 INFO - PROCESS | 22555 | 12:34:01 INFO - PROCESS | 22555 | [#1] ext.html Cycles:180 Average:39522.30 Median:18226.97 stddev:67442.04 (370.0%) stddev-sans-first:67567.76 12:34:01 INFO - PROCESS | 22555 | Values: 552.8 595.8 601.7 606.6 620.3 32440.4 33616.0 33697.2 33707.0 33714.3 36082.6 36487.6 36597.7 36621.6 36871.3 7238.5 7549.4 7736.8 7738.0 7740.6 9554.1 9990.5 10034.1 10038.4 10050.0 9649.3 9819.8 9821.7 9825.2 9835.7 7423.4 9561.1 9576.9 9791.6 10030.5 9563.8 9662.9 9699.5 9701.4 9709.4 33709.8 34142.7 34217.3 34274.0 34275.1 3003.7 3100.9 3174.9 3187.5 3501.0 28224.7 28325.7 29062.9 29232.4 29761.0 3314.6 3478.4 3508.0 3508.9 3556.6 201723.0 202805.0 204560.0 205152.0 206207.0 32741.2 50483.0 51597.0 51626.7 51647.2 31558.7 31568.4 31633.8 31718.5 31746.7 13233.7 13453.1 13462.5 13467.9 13475.9 9474.6 11079.4 11116.3 11345.0 11392.5 7891.8 7910.0 7949.1 7980.0 7990.1 3161.9 3233.9 3248.6 3251.9 3271.7 819.7 907.5 944.9 1019.0 1079.6 26896.4 26999.0 27113.5 27293.2 27530.4 959.2 961.0 988.8 1011.3 1101.5 14715.9 14874.6 14884.0 15117.3 15208.5 327515.0 332427.0 332613.0 332822.0 333121.0 47086.0 47664.2 47700.3 47729.5 47753.0 1042.5 1147.7 1219.6 1226.0 1330.8 24777.5 25219.5 26203.7 27217.8 27744.2 36774.4 37841.8 38079.4 38083.0 38141.2 215439.0 216088.0 216165.0 216851.0 217725.0 22421.8 24827.0 24913.0 25328.5 25610.1 35276.1 35513.5 35560.6 36096.8 36403.0 30523.7 30946.8 31153.8 31336.0 32048.7 33135.8 33139.3 33342.7 33515.8 33731.8 33217.5 33343.5 33788.7 33872.7 34079.3 29122.9 30323.2 30378.8 30562.2 30569.5 23435.9 23437.2 23444.0 23761.3 23804.3 12:34:01 INFO - PROCESS | 22555 | 12:34:01 INFO - PROCESS | 22555 | [#2] jquery.html Cycles:180 Average:22307.81 Median:19916.97 stddev:52091.75 (261.5%) stddev-sans-first:52211.86 12:34:01 INFO - PROCESS | 22555 | Values: 380.2 385.3 388.0 392.5 398.8 15517.6 16692.5 16809.2 16870.3 16927.5 15649.7 16222.8 16345.8 16348.7 16359.1 5056.0 5195.7 5227.6 5245.3 5245.9 3602.5 5452.6 6006.4 6014.0 6015.1 5864.1 5917.9 5921.4 5936.8 5952.4 5771.8 5926.3 5942.1 5947.8 5957.0 3342.2 4894.7 5204.2 5235.5 5246.9 19950.7 20030.9 20605.6 21128.5 21681.3 1957.5 2050.0 2062.9 2122.6 2142.8 12913.7 13228.2 13248.1 13418.1 13628.3 1514.6 1651.4 1741.6 1757.6 1813.5 64694.4 67710.9 69129.7 69245.7 69748.0 9880.3 10057.0 10275.3 10476.1 10715.6 14153.4 14206.6 14231.4 14273.5 14273.6 7274.1 7351.3 7523.5 7693.7 7711.0 7441.6 7490.6 7548.0 7628.3 7645.8 6060.4 6208.9 6305.0 6307.7 6355.6 1642.2 1764.7 1848.9 1856.0 1860.7 873.8 877.8 897.8 941.1 991.2 17957.0 18115.0 18185.7 18263.2 18311.7 869.3 879.8 910.7 919.6 994.7 9976.1 10174.9 10337.5 10352.1 10405.6 287956.0 293855.0 294311.5 294756.0 378728.0 65726.0 72494.0 80227.2 85283.0 86663.6 980.2 1002.3 1006.4 1028.4 1029.2 14910.7 15191.0 15517.1 15525.5 15708.5 35901.8 36231.5 36710.6 36966.4 37364.4 48220.8 51116.7 51363.0 51548.5 51595.0 7413.7 7521.1 7617.2 7699.5 7779.9 8358.6 11195.7 11323.4 11749.0 11892.3 9920.0 10144.7 10406.5 10464.9 10616.0 9527.2 10082.7 10249.3 10419.2 10589.3 10210.9 10416.8 10418.4 10663.8 10784.9 7517.1 7529.4 7650.7 7663.5 7671.2 10026.4 10039.8 10146.3 10149.6 10345.4 12:34:01 INFO - PROCESS | 22555 | 12:34:01 INFO - PROCESS | 22555 | [#3] mootools.html Cycles:180 Average:5153.08 Median:5436.40 stddev:2826.47 (52.0%) stddev-sans-first:2819.65 12:34:01 INFO - PROCESS | 22555 | Values: 1312.0 1381.4 1432.9 1530.7 1780.6 6778.3 7613.8 7792.1 7824.0 7836.9 7618.0 7769.3 7775.0 7775.8 7783.3 1817.2 2158.3 2209.8 2229.5 2238.7 2272.9 2294.4 2294.5 2294.8 2295.5 2182.2 2216.8 2218.4 2219.5 2224.3 1883.5 2163.4 2210.6 2219.7 2223.7 2131.8 2141.9 2154.6 2154.7 2163.2 7625.3 7672.0 7688.3 7699.6 7735.3 4329.7 4461.2 4487.1 4506.6 4507.4 3014.2 3025.0 3085.6 3105.4 3123.4 1011.5 1055.0 1058.5 1060.2 1066.3 10044.0 10311.2 10371.2 10397.5 10809.7 4035.6 4117.8 4224.0 4260.9 4264.2 8579.1 8611.1 8622.8 8627.2 8628.0 3970.4 4463.8 4468.5 4472.5 4476.0 4144.1 4246.3 4257.8 4275.4 4292.1 3469.4 3471.5 3527.2 3568.9 3612.5 1070.2 1086.3 1086.5 1086.6 1096.3 797.9 912.2 912.9 926.6 946.8 5438.0 5706.7 5713.1 5744.8 5764.9 926.1 938.4 943.1 948.7 969.1 3759.4 3850.5 3973.6 3980.8 3984.1 9222.0 9551.9 9641.8 9648.1 9664.8 9710.4 9710.6 9799.7 9844.6 9855.6 7274.8 7320.4 7377.1 7426.1 7507.8 5434.8 5499.5 5576.2 5577.3 5736.3 8939.9 9007.8 9051.2 9103.5 9199.5 8661.7 8868.8 8884.0 8887.5 8980.7 6064.2 6224.9 6231.8 6637.6 6798.9 7139.6 7401.0 7403.4 7428.6 7430.1 6467.7 6679.6 6718.7 6830.6 6883.3 6753.3 6777.9 6782.4 6875.9 6899.9 6503.5 6525.4 6591.3 6601.8 6635.6 4854.0 4880.2 4951.6 5012.4 5039.5 4637.4 4652.6 4676.6 4704.6 4774.1 12:34:01 INFO - PROCESS | 22555 | 12:34:01 INFO - PROCESS | 22555 | [#4] prototype.html Cycles:180 Average:4525.36 Median:5158.07 stddev:1308.24 (25.4%) stddev-sans-first:1273.30 12:34:01 INFO - PROCESS | 22555 | Values: 321.8 322.1 326.4 330.3 332.5 5153.1 5197.0 5203.2 5208.7 5229.4 5126.8 5149.3 5163.0 5165.8 5174.6 3810.2 3878.8 4070.2 4072.3 4080.4 4043.3 4044.0 4050.7 4053.8 4062.9 3809.0 4008.9 4015.9 4019.6 4040.0 3895.0 4021.2 4041.2 4048.9 4050.5 3571.7 3583.3 3591.8 3592.4 3593.7 4899.7 4901.6 4916.4 4934.6 4967.9 4552.2 4598.4 4640.8 4652.7 4660.9 5374.5 5393.8 5394.1 5418.1 5430.6 3918.3 3919.8 3938.5 3939.2 3942.3 5517.6 5672.4 5677.0 5716.2 5724.5 3995.6 4008.5 4009.5 4037.0 4041.5 4096.3 4096.5 4098.9 4103.4 4113.5 4369.1 4612.4 4627.7 4628.8 4647.6 5427.9 5434.3 5440.5 5459.6 5477.0 1411.8 1436.1 1439.0 1439.7 1443.4 926.5 976.8 994.5 1001.3 1017.2 4783.4 4806.1 4813.0 4813.7 4833.6 5576.6 5591.9 5592.3 5598.9 5601.5 4670.4 4800.7 4819.6 4820.2 4821.1 2940.4 2970.9 2980.9 2984.5 2985.6 5252.7 5255.7 5257.4 5272.3 5287.8 5551.7 5735.9 5812.8 5826.9 5840.5 5315.1 5334.1 5349.4 5366.7 5382.4 5337.5 5652.5 5658.3 5668.9 5674.9 5580.9 5604.7 5609.8 5611.9 5633.7 5360.4 5368.4 5370.6 5383.4 5385.5 3689.0 3909.7 3937.8 3949.3 3963.8 5595.1 5604.7 5609.6 5611.8 5612.8 5394.8 5405.5 5420.1 5434.2 5437.2 5334.4 5342.0 5403.2 5423.8 5433.4 5088.8 5289.7 5317.3 5323.7 5325.9 5295.7 5482.0 5495.3 5518.8 5522.1 5363.4 5373.6 5374.5 5380.3 5386.0 12:34:01 INFO - PROCESS | 22555 | 12:34:01 INFO - PROCESS | 22555 | [#5] yui.html Cycles:180 Average:12646.55 Median:485.88 stddev:14452.76 (2974.5%) stddev-sans-first:14465.65 12:34:01 INFO - PROCESS | 22555 | Values: 740.5 771.9 781.3 784.2 784.7 12304.4 12535.5 12618.1 12657.1 12659.9 12839.5 12904.0 12929.3 12973.7 12997.6 639.3 814.8 820.1 820.3 820.9 779.7 811.7 814.6 815.5 815.6 845.9 846.2 850.0 850.2 850.7 669.9 813.2 845.3 845.9 846.1 614.6 614.8 615.1 615.5 615.7 12090.1 12127.9 12176.6 12206.5 12219.7 11997.8 12481.7 12568.7 12796.7 13021.6 10134.0 10168.4 10243.9 10428.4 10444.7 3264.5 3265.9 3306.3 3323.0 3404.0 49653.5 49747.3 50088.5 50273.0 50432.2 9880.0 9916.6 9916.8 10012.2 10051.5 16751.3 16773.7 16796.8 16804.7 16824.6 6704.7 6739.3 6799.6 6840.2 6976.1 3742.8 3787.5 3821.5 3862.3 3983.9 2903.5 3007.4 3010.3 3015.1 3017.3 491.4 504.9 511.7 518.5 519.3 480.4 539.4 585.7 610.2 614.2 7189.0 7584.9 7637.4 7971.7 7987.8 607.4 638.4 639.8 646.9 650.0 3586.1 3685.9 3690.0 3705.9 3711.6 49610.0 49710.0 52671.5 53515.5 53712.0 44581.6 44687.1 44750.9 44968.6 45394.8 42428.6 42701.6 42729.0 42953.1 43345.3 7197.9 7271.1 7318.8 7337.7 7486.1 26847.9 27126.2 27449.9 27521.9 27616.6 34692.8 35448.0 37786.0 38187.4 38344.0 9495.3 9721.4 10582.9 10592.3 10746.6 11898.2 11906.4 11974.2 12037.9 12651.9 8085.9 9892.6 10518.8 10876.6 11064.8 10811.8 11003.2 11060.7 11119.7 11147.3 9505.0 9565.8 9782.8 10028.5 10397.7 9330.2 9413.5 9553.3 9570.3 9584.0 8915.8 9154.9 9738.6 9754.7 9817.2 12:34:01 INFO - PROCESS | 22555 | -------- Summary: end -------- 12:34:01 INFO - PROCESS | 22555 | 12:34:02 INFO - TEST-INFO | 22555: exit 0 12:34:02 INFO - TEST-OK | dromaeo_css | took 1120553ms 12:34:02 INFO - TEST-START | kraken 12:34:02 INFO - operating with platform_type : linux_ 12:34:02 INFO - Initialising browser for kraken test... 12:34:02 INFO - TEST-INFO | started process 22738 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9nVlAW/profile http://localhost:46611/getInfo.html) 12:34:07 INFO - PROCESS | 22738 | __metrics Screen width/height:1600/1200 12:34:07 INFO - PROCESS | 22738 | colorDepth:24 12:34:07 INFO - PROCESS | 22738 | Browser inner width/height: 1024/697 12:34:07 INFO - PROCESS | 22738 | __metrics 12:34:09 ERROR - PROCESS | 22738 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 12:34:10 INFO - TEST-INFO | 22738: exit 0 12:34:10 INFO - Browser initialized. 12:34:10 INFO - Running cycle 1/1 for kraken test... 12:34:10 INFO - TEST-INFO | started process 22818 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9nVlAW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:34:22 INFO - PROCESS | 22818 | RSS: Main: 154607616 12:34:22 INFO - PROCESS | 22818 | 12:34:24 INFO - PROCESS | 22818 | Cycle 1(1): loaded http://localhost:46611/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46611/tests/kraken/driver.html?testName=audio-beat-detection) 12:34:25 INFO - PROCESS | 22818 | RSS: Main: 208728064 12:34:25 INFO - PROCESS | 22818 | 12:34:28 INFO - PROCESS | 22818 | Cycle 1(1): loaded http://localhost:46611/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46611/tests/kraken/driver.html?testName=audio-dft) 12:34:29 INFO - PROCESS | 22818 | RSS: Main: 194437120 12:34:29 INFO - PROCESS | 22818 | 12:34:32 INFO - PROCESS | 22818 | Cycle 1(1): loaded http://localhost:46611/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46611/tests/kraken/driver.html?testName=audio-fft) 12:34:33 INFO - PROCESS | 22818 | RSS: Main: 265633792 12:34:33 INFO - PROCESS | 22818 | 12:34:35 INFO - PROCESS | 22818 | Cycle 1(1): loaded http://localhost:46611/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46611/tests/kraken/driver.html?testName=audio-oscillator) 12:34:35 INFO - PROCESS | 22818 | RSS: Main: 173445120 12:34:35 INFO - PROCESS | 22818 | 12:34:38 INFO - PROCESS | 22818 | Cycle 1(1): loaded http://localhost:46611/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46611/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:34:38 INFO - PROCESS | 22818 | RSS: Main: 178253824 12:34:38 INFO - PROCESS | 22818 | 12:34:41 INFO - PROCESS | 22818 | Cycle 1(1): loaded http://localhost:46611/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46611/tests/kraken/driver.html?testName=imaging-darkroom) 12:34:42 INFO - PROCESS | 22818 | RSS: Main: 214183936 12:34:42 INFO - PROCESS | 22818 | 12:34:45 INFO - PROCESS | 22818 | Cycle 1(1): loaded http://localhost:46611/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46611/tests/kraken/driver.html?testName=imaging-desaturate) 12:34:46 INFO - PROCESS | 22818 | RSS: Main: 214540288 12:34:46 INFO - PROCESS | 22818 | 12:34:49 INFO - PROCESS | 22818 | Cycle 1(1): loaded http://localhost:46611/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46611/tests/kraken/driver.html?testName=json-parse-financial) 12:34:49 INFO - PROCESS | 22818 | RSS: Main: 214401024 12:34:49 INFO - PROCESS | 22818 | 12:34:51 INFO - PROCESS | 22818 | Cycle 1(1): loaded http://localhost:46611/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46611/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:34:52 INFO - PROCESS | 22818 | RSS: Main: 201666560 12:34:52 INFO - PROCESS | 22818 | 12:34:54 INFO - PROCESS | 22818 | Cycle 1(1): loaded http://localhost:46611/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46611/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:34:54 INFO - PROCESS | 22818 | RSS: Main: 204136448 12:34:54 INFO - PROCESS | 22818 | 12:34:56 INFO - PROCESS | 22818 | Cycle 1(1): loaded http://localhost:46611/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46611/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:34:57 INFO - PROCESS | 22818 | RSS: Main: 217595904 12:34:57 INFO - PROCESS | 22818 | 12:35:00 INFO - PROCESS | 22818 | Cycle 1(1): loaded http://localhost:46611/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46611/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:35:00 INFO - PROCESS | 22818 | RSS: Main: 223862784 12:35:00 INFO - PROCESS | 22818 | 12:35:03 INFO - PROCESS | 22818 | Cycle 1(1): loaded http://localhost:46611/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46611/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:35:04 INFO - PROCESS | 22818 | RSS: Main: 219099136 12:35:04 INFO - PROCESS | 22818 | 12:35:06 INFO - PROCESS | 22818 | Cycle 1(1): loaded http://localhost:46611/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46611/tests/kraken/driver.html?testName=ai-astar) 12:35:06 INFO - PROCESS | 22818 | RSS: Main: 281419776 12:35:06 INFO - PROCESS | 22818 | 12:35:06 INFO - PROCESS | 22818 | __start_tp_report 12:35:06 INFO - PROCESS | 22818 | _x_x_mozilla_page_load 12:35:06 INFO - PROCESS | 22818 | _x_x_mozilla_page_load_details 12:35:06 INFO - PROCESS | 22818 | |i|pagename|runs| 12:35:06 INFO - PROCESS | 22818 | |0;ai-astar;110;113;107;113;112;114;101;113;112;112 12:35:06 INFO - PROCESS | 22818 | |1;audio-beat-detection;162;132;157;182;132;156;155;133;205;138 12:35:06 INFO - PROCESS | 22818 | |2;audio-dft;162;160;160;162;161;161;161;160;161;161 12:35:06 INFO - PROCESS | 22818 | |3;audio-fft;73;73;101;105;78;76;73;113;98;74 12:35:06 INFO - PROCESS | 22818 | |4;audio-oscillator;94;94;149;94;95;94;152;92;93;144 12:35:06 INFO - PROCESS | 22818 | |5;imaging-gaussian-blur;117;116;117;117;116;117;117;117;116;116 12:35:06 INFO - PROCESS | 22818 | |6;imaging-darkroom;146;146;146;146;147;146;146;146;146;146 12:35:06 INFO - PROCESS | 22818 | |7;imaging-desaturate;95;95;96;96;96;100;95;96;95;95 12:35:06 INFO - PROCESS | 22818 | |8;json-parse-financial;66;67;67;68;67;66;67;83;64;64 12:35:06 INFO - PROCESS | 22818 | |9;json-stringify-tinderbox;64;64;64;64;66;66;65;65;65;65 12:35:06 INFO - PROCESS | 22818 | |10;stanford-crypto-aes;84;83;84;83;83;84;84;84;85;86 12:35:06 INFO - PROCESS | 22818 | |11;stanford-crypto-ccm;138;139;138;138;133;149;137;139;175;137 12:35:06 INFO - PROCESS | 22818 | |12;stanford-crypto-pbkdf2;169;170;169;171;172;170;175;171;169;171 12:35:06 INFO - PROCESS | 22818 | |13;stanford-crypto-sha256-iterative;72;73;72;72;71;72;72;70;77;71 12:35:06 INFO - PROCESS | 22818 | __end_tp_report 12:35:06 INFO - PROCESS | 22818 | __start_cc_report 12:35:06 INFO - PROCESS | 22818 | _x_x_mozilla_cycle_collect,1870 12:35:06 INFO - PROCESS | 22818 | __end_cc_report 12:35:06 INFO - PROCESS | 22818 | __startTimestamp1460662506515__endTimestamp 12:35:06 INFO - PROCESS | 22818 | 12:35:06 INFO - PROCESS | 22818 | ------- Summary: start ------- 12:35:06 INFO - PROCESS | 22818 | Number of tests: 14 12:35:06 INFO - PROCESS | 22818 | 12:35:06 INFO - PROCESS | 22818 | [#0] ai-astar Cycles:10 Average:110.70 Median:112.50 stddev:3.95 (3.5%) stddev-sans-first:4.18 12:35:06 INFO - PROCESS | 22818 | Values: 110.0 113.0 107.0 113.0 112.0 114.0 101.0 113.0 112.0 112.0 12:35:06 INFO - PROCESS | 22818 | 12:35:06 INFO - PROCESS | 22818 | [#1] audio-beat-detection Cycles:10 Average:155.20 Median:156.50 stddev:23.84 (15.2%) stddev-sans-first:25.16 12:35:06 INFO - PROCESS | 22818 | Values: 162.0 132.0 157.0 182.0 132.0 156.0 155.0 133.0 205.0 138.0 12:35:06 INFO - PROCESS | 22818 | 12:35:06 INFO - PROCESS | 22818 | [#2] audio-dft Cycles:10 Average:160.90 Median:161.00 stddev:0.74 (0.5%) stddev-sans-first:0.67 12:35:06 INFO - PROCESS | 22818 | Values: 162.0 160.0 160.0 162.0 161.0 161.0 161.0 160.0 161.0 161.0 12:35:06 INFO - PROCESS | 22818 | 12:35:06 INFO - PROCESS | 22818 | [#3] audio-fft Cycles:10 Average:86.40 Median:73.50 stddev:15.89 (21.6%) stddev-sans-first:16.10 12:35:06 INFO - PROCESS | 22818 | Values: 73.0 73.0 101.0 105.0 78.0 76.0 73.0 113.0 98.0 74.0 12:35:06 INFO - PROCESS | 22818 | 12:35:06 INFO - PROCESS | 22818 | [#4] audio-oscillator Cycles:10 Average:110.10 Median:94.00 stddev:26.46 (28.2%) stddev-sans-first:27.42 12:35:06 INFO - PROCESS | 22818 | Values: 94.0 94.0 149.0 94.0 95.0 94.0 152.0 92.0 93.0 144.0 12:35:06 INFO - PROCESS | 22818 | 12:35:06 INFO - PROCESS | 22818 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 12:35:06 INFO - PROCESS | 22818 | Values: 117.0 116.0 117.0 117.0 116.0 117.0 117.0 117.0 116.0 116.0 12:35:06 INFO - PROCESS | 22818 | 12:35:06 INFO - PROCESS | 22818 | [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.00 stddev:0.32 (0.2%) stddev-sans-first:0.33 12:35:06 INFO - PROCESS | 22818 | Values: 146.0 146.0 146.0 146.0 147.0 146.0 146.0 146.0 146.0 146.0 12:35:06 INFO - PROCESS | 22818 | 12:35:06 INFO - PROCESS | 22818 | [#7] imaging-desaturate Cycles:10 Average:95.90 Median:95.50 stddev:1.52 (1.6%) stddev-sans-first:1.58 12:35:06 INFO - PROCESS | 22818 | Values: 95.0 95.0 96.0 96.0 96.0 100.0 95.0 96.0 95.0 95.0 12:35:06 INFO - PROCESS | 22818 | 12:35:06 INFO - PROCESS | 22818 | [#8] json-parse-financial Cycles:10 Average:67.90 Median:67.00 stddev:5.47 (8.2%) stddev-sans-first:5.75 12:35:06 INFO - PROCESS | 22818 | Values: 66.0 67.0 67.0 68.0 67.0 66.0 67.0 83.0 64.0 64.0 12:35:06 INFO - PROCESS | 22818 | 12:35:06 INFO - PROCESS | 22818 | [#9] json-stringify-tinderbox Cycles:10 Average:64.80 Median:65.00 stddev:0.79 (1.2%) stddev-sans-first:0.78 12:35:06 INFO - PROCESS | 22818 | Values: 64.0 64.0 64.0 64.0 66.0 66.0 65.0 65.0 65.0 65.0 12:35:06 INFO - PROCESS | 22818 | 12:35:06 INFO - PROCESS | 22818 | [#10] stanford-crypto-aes Cycles:10 Average:84.00 Median:84.00 stddev:0.94 (1.1%) stddev-sans-first:1.00 12:35:06 INFO - PROCESS | 22818 | Values: 84.0 83.0 84.0 83.0 83.0 84.0 84.0 84.0 85.0 86.0 12:35:06 INFO - PROCESS | 22818 | 12:35:06 INFO - PROCESS | 22818 | [#11] stanford-crypto-ccm Cycles:10 Average:142.30 Median:138.50 stddev:12.18 (8.8%) stddev-sans-first:12.81 12:35:06 INFO - PROCESS | 22818 | Values: 138.0 139.0 138.0 138.0 133.0 149.0 137.0 139.0 175.0 137.0 12:35:06 INFO - PROCESS | 22818 | 12:35:06 INFO - PROCESS | 22818 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.70 Median:171.00 stddev:1.83 (1.1%) stddev-sans-first:1.83 12:35:06 INFO - PROCESS | 22818 | Values: 169.0 170.0 169.0 171.0 172.0 170.0 175.0 171.0 169.0 171.0 12:35:06 INFO - PROCESS | 22818 | 12:35:06 INFO - PROCESS | 22818 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.20 Median:72.00 stddev:1.87 (2.6%) stddev-sans-first:1.99 12:35:06 INFO - PROCESS | 22818 | Values: 72.0 73.0 72.0 72.0 71.0 72.0 72.0 70.0 77.0 71.0 12:35:06 INFO - PROCESS | 22818 | -------- Summary: end -------- 12:35:06 INFO - PROCESS | 22818 | 12:35:07 INFO - TEST-INFO | 22818: exit 0 12:35:07 INFO - TEST-OK | kraken | took 65135ms 12:35:07 INFO - SUITE-END | took 1185s 12:35:08 INFO - Completed test suite (00:19:46) 12:35:08 INFO - javascript benchmark 12:35:08 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2636.8813403396853, 2669.9186829334126, 2694.838309701418, 2718.347596576822, 2733.617293578899, 4622.815087396509, 4669.0428462165255, 4688.765561721917, 4688.812447502096, 4734.644901632379, 4586.243269860477, 4631.652626053043, 4659.88350291242, 4672.392588963438, 4679.110968915904, 4242.109157077018, 4261.722988005785, 4265.104328091104, 4284.036091879318, 4317.11499142675, 4298.548652391485, 4347.586979236968, 4397.890052748691, 4423.447069116361, 4431.911361772763, 4204.957950420488, 4295.076558539898, 4300.22595932732, 4327.459067616548, 4372.562743725618, 4209.536950935395, 4211.43145675333, 4214.620684138442, 4215.494140703136, 4225.746455212667, 4201.117765269297, 4202.138561594897, 4205.768682722449, 4206.684498662582, 4217.97891010546, 4569.611583015448, 4571.794269257892, 4660.720356778605, 4676.0, 4694.08465349257, 4939.357883475125, 4940.110780059588, 4953.1332016896895, 4956.504349565051, 4992.950070499285, 4957.752112394402, 4961.875953101166, 4964.975175124101, 4967.031428871372, 4981.053599816023, 4486.887827804331, 4648.6745927785405, 4673.065386922561, 4706.152892479318, 4719.504452032487, 5075.213341932006, 5076.314697515862, 5079.619028572872, 5086.593072554187, 5144.511271429283, 4849.151398505318, 4878.902421951541, 4883.194272944925, 4890.6332025097545, 4943.431505376856, 4974.527419895104, 5007.298978143063, 5028.044671512474, 5072.746362681851, 5077.162268225775, 4923.975380123076, 4928.186849169919, 4933.161362568372, 4966.180580204225, 4984.526469985346, 4815.15734746418, 4847.733374664357, 4922.532359425849, 4926.655134140576, 4964.751762411937, 4244.193603215379, 4245.596668316505, 4255.148970205972, 4270.359446083113, 4289.120730250291, 3708.2212735325884, 3722.8883133506038, 3726.4782930389765, 3757.267332870119, 3771.7925514096987, 4294.806733696991, 4368.148211098805, 4369.0, 4381.518033016366, 4429.68992170545, 4942.802287908444, 4956.776945037482, 4992.8002879885125, 5022.321986531844, 5054.671446355975, 4339.82640694375, 4369.2790689536505, 4370.781460926941, 4371.0602220522105, 4413.051193993307, 4410.69125161242, 4518.593326600556, 4521.638268938477, 4523.208438523311, 4560.84037058708, 4735.2186889163595, 4762.333273341805, 4787.61699064067, 4829.806807727651, 4835.032993401404, 5006.0, 5007.974960125176, 5022.422421421437, 5024.271480635361, 5077.0, 4576.084783043338, 4701.764911754467, 4712.646551508582, 4712.905741885212, 4761.095391875532, 4863.708177509361, 4872.074305881871, 4873.439554451284, 4876.902461950812, 4921.188003979303, 4977.800887964441, 4987.576056035277, 4993.051320249141, 4994.350734404504, 5024.070546948826, 4652.255639097728, 4843.854684359334, 4844.588210002048, 4900.2894580286375, 4903.901921961612, 4878.536539028786, 4896.461389247252, 4897.804087836446, 4919.286703428054, 4950.6782059166035, 4812.807487700453, 4829.6860704054125, 4830.178869592108, 4833.830815921426, 4881.536254055859, 4811.759412029454, 4879.024195160911, 4879.731614761222, 4884.78018489176, 4916.508349165055, 4752.144613969519, 4770.928436073392, 4787.736674482937, 4793.520647935178, 4793.760311984317], "value": 4587.092128065694, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [552.8175702018332, 595.8063629320469, 601.6811090122235, 606.6360183889664, 620.3083561828561, 32440.351192976155, 33615.9915202544, 33697.15757106068, 33707.0, 33714.32571348571, 36082.63917360826, 36487.63512364875, 36597.71907983221, 36621.63378366215, 36871.262574748485, 7238.493305468619, 7549.433792465573, 7736.806579835521, 7737.961310193441, 7740.574268415235, 9554.140127388533, 9990.50047497626, 10034.147097496685, 10038.44404117363, 10050.045245701647, 9649.324547281693, 9819.803603927918, 9821.705348839547, 9825.213982881389, 9835.65575204868, 7423.40612750984, 9561.091696288842, 9576.856347154799, 9791.608335666564, 10030.49847507629, 9563.760905977406, 9662.90337096627, 9699.51502424876, 9701.417914925127, 9709.417434953926, 33709.83145084284, 34142.6585734142, 34217.31565368679, 34274.0, 34275.14312142217, 3003.7296643302207, 3100.875964961399, 3174.888878889251, 3187.474066778979, 3501.0, 28224.717752822413, 28325.716742832516, 29062.854685726437, 29232.41535169306, 29761.0, 3314.6022477302636, 3478.3738926993133, 3508.0177550285707, 3508.9297764181915, 3556.6443355664487, 201723.0, 202805.0, 204560.0, 205152.0, 206207.0, 32741.18147046343, 50483.0, 51597.0, 51626.74186629043, 51647.225291620656, 31558.684413156032, 31568.368632627218, 31633.84183079116, 31718.524222136686, 31746.68253317437, 13233.73532529344, 13453.125546839425, 13462.528811491551, 13467.86532134666, 13475.932620337031, 9474.573644186028, 11079.390633515233, 11116.277441966246, 11345.0, 11392.544298227978, 7891.802704932308, 7910.0, 7949.125596184415, 7979.9601001994615, 7990.12108668046, 3161.9051428457183, 3233.9029829105166, 3248.577684900995, 3251.9349613007607, 3271.7382609391193, 819.7090033038305, 907.5280853955906, 944.8960614332418, 1018.974525636865, 1079.578964203961, 26896.413944660715, 26999.0, 27113.45773084567, 27293.181204563894, 27530.44939101207, 959.2230293462318, 961.0, 988.8417853143462, 1011.2920955331298, 1101.4878081692052, 14715.852841471662, 14874.553763387115, 14884.0, 15117.319720612599, 15208.46770363032, 327515.0, 332427.0, 332613.0, 332822.0, 333121.0, 47086.0, 47664.23357664206, 47700.284495732594, 47729.522704773204, 47753.0, 1042.499600191897, 1147.701597584634, 1219.621917205669, 1226.0314351662266, 1330.8269924909894, 24777.504449911263, 25219.495610087328, 26203.724534433197, 27217.76508589449, 27744.167674969784, 36774.44838327481, 37841.81079094697, 38079.428808568446, 38083.04792380213, 38141.23717525578, 215439.0, 216088.0, 216165.0, 216851.0, 217725.0, 22421.77578224197, 24827.0, 24913.0, 25328.493430131664, 25610.10364637229, 35276.118097046754, 35513.46729799107, 35560.64439355573, 36096.81951590225, 36403.0, 30523.694763052084, 30946.84526577353, 31153.8442307787, 31336.0, 32048.67951320457, 33135.83432082824, 33139.33721325608, 33342.666573333954, 33515.83242083774, 33731.83134084314, 33217.501737473474, 33343.49984750279, 33788.66211337855, 33872.66127338695, 34079.318413632085, 29122.854385727936, 30323.241918952204, 30378.84810575933, 30562.235944100685, 30569.54145687772, 23435.882820585786, 23437.179698710464, 23444.0, 23761.287161385186, 23804.285871423886], "value": 15976.548894231813, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [380.16397673356755, 385.2872186455058, 387.9786611736355, 392.48976330769995, 398.80458575298115, 15517.602160287763, 16692.49922502324, 16809.24358403872, 16870.325186992504, 16927.492175234747, 15649.687006259868, 16222.83777162228, 16345.754813677804, 16348.673026539493, 16359.100249486273, 5055.974720126404, 5195.714235717034, 5227.60792940531, 5245.344331958505, 5245.8950820983555, 3602.477640742091, 5452.645578037414, 6006.369331220225, 6013.969930150343, 6015.067664511986, 5864.149698293745, 5917.852053698649, 5921.378255283198, 5936.762529498815, 5952.4047595240345, 5771.797987070453, 5926.348101708809, 5942.138389933435, 5947.762089516415, 5957.0, 3342.197872510604, 4894.657373983822, 5204.167333226704, 5235.528802407802, 5246.921296180561, 19950.70073948892, 20030.857919620554, 20605.587888242302, 21128.471788205265, 21681.34955951324, 1957.4910523263911, 2049.98975005124, 2062.9174833006664, 2122.639151344275, 2142.7964343387353, 12913.662599109288, 13228.206307621573, 13248.106344121448, 13418.12970261562, 13628.318584070856, 1514.6289159156076, 1651.3972400074006, 1741.6255505066472, 1757.5957529768098, 1813.5103522049105, 64694.35305646931, 67710.85903403026, 69129.65435172792, 69245.65377173082, 69747.95378069383, 9880.258980576486, 10057.0, 10275.332103413255, 10476.109530689977, 10715.624953126604, 14153.43386264538, 14206.644833879029, 14231.43074277038, 14273.500427484989, 14273.643158920902, 7274.090738657668, 7351.338379545759, 7523.548587084792, 7693.730719424793, 7710.96144519285, 7441.627918604048, 7490.550566966, 7547.962260188664, 7628.313451789366, 7645.770626881203, 6060.363661815534, 6208.937910620836, 6304.968475157595, 6307.716152773136, 6355.586886852339, 1642.1707037945762, 1764.7264673975553, 1848.935287264966, 1856.0070362356075, 1860.7394964704952, 873.8427083125099, 877.8463768840427, 897.8294124116397, 941.0683423410774, 991.2070343724992, 17957.0, 18115.0, 18185.7272140918, 18263.17815698297, 18311.705792325552, 869.2741560796679, 879.846026945282, 910.7040211931148, 919.6382954449588, 994.7264502261792, 9976.102150806462, 10174.949125254327, 10337.483125843677, 10352.120069794151, 10405.635802746867, 287956.0, 293855.0, 294311.52844235644, 294756.0, 378728.0, 65726.04232809535, 72494.0, 80227.19772802314, 85283.0, 86663.56668216619, 980.1913421427352, 1002.2633364477249, 1006.431366278036, 1028.3726926574784, 1029.1509504658686, 14910.701785964437, 15191.0, 15517.146556939026, 15525.45660901863, 15708.450204242796, 35901.82049089738, 36231.456528151575, 36710.63289367179, 36966.445503316936, 37364.43953340757, 48220.7588962053, 51116.74441627768, 51363.0, 51548.48451515437, 51595.0, 7413.703451861865, 7521.0974683038385, 7617.238276172338, 7699.538027718355, 7779.92220077792, 8358.623861926106, 11195.664130076111, 11323.433828308387, 11749.0, 11892.286462812259, 9920.007999200023, 10144.746381340525, 10406.531706073396, 10464.895351046393, 10616.0, 9527.237820974444, 10082.747931301776, 10249.33379330341, 10419.166466682798, 10589.311694739818, 10210.897891020995, 10416.843747343948, 10418.426986515815, 10663.840042399526, 10784.89215107839, 7517.135529414188, 7529.397648188241, 7650.737628291269, 7663.501872378278, 7671.1561728208735, 10026.398416095057, 10039.799204016024, 10146.289759716748, 10149.64476243328, 10345.431001295], "value": 8448.647917726408, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1311.9504396482812, 1381.4267079162146, 1432.9498467553635, 1530.6862093270881, 1780.5548612846787, 6778.254392016875, 7613.809654758634, 7792.064952205729, 7824.021997250344, 7836.882446763303, 7618.047744031996, 7769.300762931335, 7775.0, 7775.766726998185, 7783.299503044725, 1817.182267979408, 2158.2877650375417, 2209.845310828243, 2229.487217939875, 2238.6865838782583, 2272.8977196026217, 2294.357579877637, 2294.4608017115966, 2294.827887908405, 2295.494991101963, 2182.2034957240653, 2216.833737469688, 2218.3566765638025, 2219.4673278413225, 2224.3327001899447, 1883.4537983984628, 2163.4375062483787, 2210.557888422306, 2219.655953327237, 2223.7442694090223, 2131.776163502841, 2141.871487710727, 2154.5906277807167, 2154.6983422320886, 2163.2212403534872, 7625.275598818103, 7672.0409948756405, 7688.269614386624, 7699.576523291216, 7735.265149810759, 4329.718568293051, 4461.196984542781, 4487.080148569568, 4506.571875671806, 4507.3689683444345, 3014.231371000381, 3025.0471101603143, 3085.568020477135, 3105.4254962831947, 3123.3597112591865, 1011.5144730529314, 1054.9630762923261, 1058.5395353021383, 1060.2154405739698, 1066.3441983180367, 10044.0, 10311.226658000605, 10371.222158338154, 10397.480125993745, 10809.729756756065, 4035.616616421435, 4117.773522456234, 4224.007358270804, 4260.893477663083, 4264.232438161099, 8579.099194584478, 8611.095834937367, 8622.827543449095, 8627.180417860292, 8627.95686021566, 3970.3845903884944, 4463.754493502824, 4468.50846406895, 4472.530384309665, 4475.977620111878, 4144.129732756095, 4246.299360605527, 4257.829686812493, 4275.422817919603, 4292.098659281523, 3469.4275444551367, 3471.5486986691567, 3527.153483164022, 3568.892933212008, 3612.512310838056, 1070.1813112968584, 1086.32104934416, 1086.473060565625, 1086.6468397770757, 1096.276457538021, 797.9082405523322, 912.1744820937063, 912.9041450647719, 926.6478738079621, 946.7775072857872, 5438.0121543816, 5706.71466426677, 5713.085906254979, 5744.770209191669, 5764.942350576441, 926.1340646495548, 938.3572253006712, 943.0852073488705, 948.6679662118204, 969.1471505075489, 3759.379702349082, 3850.4994350734223, 3973.6225058619384, 3980.7611543307494, 3984.1035766952205, 9222.0, 9551.856722149174, 9641.807163856824, 9648.131668149901, 9664.806703866025, 9710.368826026426, 9710.563024663907, 9799.657012004545, 9844.556994935101, 9855.605775768889, 7274.818129546804, 7320.401257553598, 7377.077865266841, 7426.108866936002, 7507.7747667568965, 5434.782608695766, 5499.5325397340075, 5576.191452239484, 5577.3028371453565, 5736.311642602915, 8939.865902011605, 9007.774805629911, 9051.185393314634, 9103.544822758968, 9199.54002299869, 8661.653533858575, 8868.77828054278, 8884.0, 8887.466751994902, 8980.685676001309, 6064.211652485149, 6224.875502490016, 6231.813045608639, 6637.6349300788925, 6798.932010680028, 7139.607321597362, 7400.962995184989, 7403.407727381904, 7428.6285685716575, 7430.108386993596, 6467.741290348334, 6679.56582822115, 6718.6976586054725, 6830.59016459014, 6883.3116688330765, 6753.257141714309, 6777.8983315249325, 6782.355676210752, 6875.931240687729, 6899.931000689929, 6503.544751867324, 6525.380088891738, 6591.274959754519, 6601.768938087144, 6635.6350400728425, 4853.951460485491, 4880.243562247857, 4951.554360107608, 5012.373453318335, 5039.496050394931, 4637.350770892145, 4652.604528615106, 4676.602488788355, 4704.5765881070865, 4774.140654682191], "value": 4186.194833807552, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [321.81174013202275, 322.1302483295103, 326.35056238086213, 330.33767296570403, 332.46971081125594, 5153.149730294497, 5196.974015129924, 5203.167493201088, 5208.713520756357, 5229.398619158798, 5126.769295381708, 5149.30484384608, 5163.0, 5165.767540460679, 5174.586033117351, 3810.2189051244427, 3878.825452854628, 4070.2266569351877, 4072.3484242521204, 4080.449139366192, 4043.2722110020186, 4043.9797801010955, 4050.7164498485117, 4053.756774593519, 4062.939055914164, 3809.0, 4008.8797336079965, 4015.9397609035886, 4019.5980401959864, 4040.0, 3895.0, 4021.235965166609, 4041.1715598302276, 4048.858289959867, 4050.534188568323, 3571.6964058055096, 3583.301256255031, 3591.8024508652015, 3592.3533763922483, 3593.7484376093685, 4899.681520701143, 4901.607871370282, 4916.434610019822, 4934.6052315815, 4967.900641987176, 4552.180607490651, 4598.379218805452, 4640.767961601907, 4652.74409907455, 4660.9237902984205, 5374.462553744634, 5393.838184854421, 5394.136938089887, 5418.078926582491, 5430.56555475561, 3918.314294998364, 3919.7844118573466, 3938.4879965604573, 3939.1530820873363, 3942.2706799242233, 5517.613767036309, 5672.376038635788, 5676.971615141939, 5716.228309178249, 5724.513416359614, 3995.6403923647013, 4008.5390180129075, 4009.498812648419, 4036.979815100906, 4041.515018197835, 4096.283150448659, 4096.508418989681, 4098.938515922264, 4103.425520427142, 4113.465249517543, 4369.148016136886, 4612.446506419251, 4627.663030169742, 4628.814847406134, 4647.604953578916, 5427.9185812212845, 5434.266374039533, 5440.455954404528, 5459.617826752169, 5476.972615136899, 1411.792917055923, 1436.0665567381286, 1438.992805035968, 1439.7480440922798, 1443.444273954535, 926.5228407370209, 976.8485884687884, 994.5176589354157, 1001.2840818814583, 1017.1659239423601, 4783.425988881357, 4806.110869489085, 4813.0, 4813.711177329372, 4833.564979151894, 5576.6096373254295, 5591.8602034948635, 5592.328920529481, 5598.888022239533, 5601.459598610333, 4670.392848929685, 4800.73595952219, 4819.5782244238035, 4820.156472617278, 4821.108095002436, 2940.3678209185127, 2970.8960186393374, 2980.940381192364, 2984.463001554201, 2985.641722993255, 5252.711100889488, 5255.684658920477, 5257.447967963385, 5272.288241087481, 5287.841364759063, 5551.694656793834, 5735.942640573624, 5812.82561523155, 5826.883462330815, 5840.532757379399, 5315.123004704258, 5334.093204155303, 5349.438308977501, 5366.651167674088, 5382.407935127211, 5337.519623233928, 5652.519535839335, 5658.292713410824, 5668.886622267614, 5674.914876276776, 5580.86047848807, 5604.719764011702, 5609.80365687199, 5611.8877622448135, 5633.746481408264, 5360.383555891122, 5368.382635996911, 5370.62405631602, 5383.353997520323, 5385.542228910586, 3688.981555092207, 3909.651170346226, 3937.822797974041, 3949.348357520977, 3963.821628026688, 5595.07681232592, 5604.663720176803, 5609.59760059985, 5611.775528978795, 5612.803551875828, 5394.78420863161, 5405.5135037846785, 5420.132778755538, 5434.184872269191, 5437.211604317431, 5334.359876814807, 5342.0, 5403.189521571796, 5423.810166644149, 5433.429489903661, 5088.821891233789, 5289.7355132244, 5317.282166907418, 5323.653962492425, 5325.893482130413, 5295.7087360195555, 5481.972590137024, 5495.313085864267, 5518.80684176068, 5522.116461366162, 5363.383210930793, 5373.596980226421, 5374.543163830962, 5380.3274590676165, 5385.973070134781], "value": 4116.306516465108, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [740.4705635470638, 771.8726410142327, 781.2851241114381, 784.1726978038167, 784.7175016993881, 12304.38478076096, 12535.498580056787, 12618.053645976543, 12657.11400201984, 12659.873401265984, 12839.48642054319, 12904.0, 12929.288889111118, 12973.740525189514, 12997.610071697864, 639.2680380963793, 814.7759366174305, 820.1306614988102, 820.3027426687328, 820.9055958564752, 779.6881247501017, 811.7280710961835, 814.633414963266, 815.4740192575786, 815.6451943404609, 845.8815765792793, 846.1622993236713, 849.9830003399959, 850.1838235294125, 850.7320194138827, 669.9397054265091, 813.1827513349047, 845.3364109174269, 845.873119032147, 846.1284876577135, 614.6127939398195, 614.8278482024996, 615.1388056720582, 615.4676205082616, 615.6860001399274, 12090.09324300681, 12127.878721212852, 12176.634700958986, 12206.450709718085, 12219.694507637292, 11997.820032699516, 12481.687957801038, 12568.74862502754, 12796.680082997906, 13021.609351719464, 10134.0, 10168.36618406318, 10243.94878025605, 10428.426436545988, 10444.68665940023, 3264.5266436366833, 3265.918352041218, 3306.322203948185, 3323.0363194673514, 3404.0298514923375, 49653.50346496525, 49747.25379119316, 50088.499115009115, 50273.0, 50432.243516347284, 9880.0, 9916.603335866628, 9916.801663966824, 10012.199024078056, 10051.547680354402, 16751.32994680199, 16773.7483937741, 16796.832031679773, 16804.6639067218, 16824.579385515215, 6704.698288577026, 6739.326067393222, 6799.5920244785475, 6840.213375461885, 6976.093107895941, 3742.812859357076, 3787.5454945406727, 3821.4840996465678, 3862.2854771867296, 3983.940240896331, 2903.535434330497, 3007.3684526249294, 3010.3076292452856, 3015.1105423900003, 3017.260771111092, 491.4053994666422, 504.9065922804293, 511.69298420947877, 518.4918779596017, 519.2885746527281, 480.3587211073256, 539.4255118298998, 585.689584520205, 610.1732152932801, 614.1586027142843, 7188.964055179691, 7584.924150758422, 7637.42719296055, 7971.72098976533, 7987.8402431951035, 607.4108115128407, 638.4158494977137, 639.8240483866881, 646.867392184601, 650.0314531348257, 3586.103474131467, 3685.9262814743556, 3689.963100368962, 3705.94441083384, 3711.628837116321, 49610.0, 49710.0, 52671.47328526666, 53515.464845351824, 53712.0, 44581.554184458386, 44687.10625787466, 44750.88122796956, 44968.55031449644, 45394.77302613532, 42428.57571424246, 42701.57298427038, 42729.0, 42953.14093718108, 43345.34981975273, 7197.928020719935, 7271.127464704269, 7318.817029574303, 7337.70649174027, 7486.064241969754, 26847.865760671073, 27126.1862144136, 27449.90200391962, 27521.86239068792, 27616.585751213344, 34692.826535867156, 35448.0, 37786.0, 38187.42718859164, 38344.0, 9495.287853410884, 9721.368111072758, 10582.894171058191, 10592.311499752492, 10746.570137194425, 11898.167128300936, 11906.40467976615, 11974.161808673658, 12037.939810300892, 12651.93674031624, 8085.8787118192095, 9892.554835032584, 10518.842217366593, 10876.564937402416, 11064.834027489755, 10811.837822432828, 11003.17476189305, 11060.723481913017, 11119.666410007712, 11147.331160130418, 9504.95247523758, 9565.808683826424, 9782.80434391294, 10028.498575071071, 10397.740056498647, 9330.160285574331, 9413.529323533932, 9553.331266811256, 9570.282228832726, 9583.952080239555, 8915.821683566162, 9154.862677059717, 9738.610455581698, 9754.658586949423, 9817.233928677599], "value": 5890.578081887963, "unit": "score"}], "name": "dromaeo_css", "value": 6305.544785264263, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 113.0, 107.0, 113.0, 112.0, 114.0, 101.0, 113.0, 112.0, 112.0], "value": 110.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 132.0, 157.0, 182.0, 132.0, 156.0, 155.0, 133.0, 205.0, 138.0], "value": 155.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 160.0, 160.0, 162.0, 161.0, 161.0, 161.0, 160.0, 161.0, 161.0], "value": 160.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 73.0, 101.0, 105.0, 78.0, 76.0, 73.0, 113.0, 98.0, 74.0], "value": 86.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 149.0, 94.0, 95.0, 94.0, 152.0, 92.0, 93.0, 144.0], "value": 110.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 116.0, 116.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 146.0, 147.0, 146.0, 146.0, 146.0, 146.0, 146.0], "value": 146.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 96.0, 96.0, 100.0, 95.0, 96.0, 95.0, 95.0], "value": 95.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 67.0, 68.0, 67.0, 66.0, 67.0, 83.0, 64.0, 64.0], "value": 67.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 64.0, 64.0, 66.0, 66.0, 65.0, 65.0, 65.0, 65.0], "value": 64.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 84.0, 83.0, 83.0, 84.0, 84.0, 84.0, 85.0, 86.0], "value": 84.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 139.0, 138.0, 138.0, 133.0, 149.0, 137.0, 139.0, 175.0, 137.0], "value": 142.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 170.0, 169.0, 171.0, 172.0, 170.0, 175.0, 171.0, 169.0, 171.0], "value": 170.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 73.0, 72.0, 72.0, 71.0, 72.0, 72.0, 70.0, 77.0, 71.0], "value": 72.2, "unit": "score"}], "name": "kraken", "value": 1583.8, "alertThreshold": 2.0}]} 12:35:08 INFO - Return code: 0 12:35:08 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 12:35:08 ERROR - # TBPL SUCCESS # 12:35:08 INFO - Running post-action listener: _resource_record_post_action 12:35:08 INFO - Running post-run listener: _resource_record_post_run 12:35:09 INFO - Total resource usage - Wall time: 1203s; CPU: 13.0%; Read bytes: 4096; Write bytes: 524120064; Read time: 20; Write time: 930028 12:35:09 INFO - install - Wall time: 16s; CPU: 16.0%; Read bytes: 0; Write bytes: 233951232; Read time: 0; Write time: 511604 12:35:09 INFO - run-tests - Wall time: 1188s; CPU: 13.0%; Read bytes: 4096; Write bytes: 290168832; Read time: 20; Write time: 418424 12:35:09 INFO - Running post-run listener: _upload_blobber_files 12:35:09 INFO - Blob upload gear active. 12:35:09 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:35:09 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 12:35:09 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'] 12:35:09 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 12:35:09 INFO - (blobuploader) - INFO - Open directory for files ... 12:35:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 12:35:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:35:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:35:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 12:35:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:35:10 INFO - (blobuploader) - INFO - Done attempting. 12:35:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 12:35:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:35:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:35:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 12:35:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:35:11 INFO - (blobuploader) - INFO - Done attempting. 12:35:11 INFO - (blobuploader) - INFO - Iteration through files over. 12:35:11 INFO - Return code: 0 12:35:11 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:35:11 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:35:11 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/93fd49a58f87f833d9fc5bfc5f3ba6ed4d9af3a8970b1efca6febeffa6f0c15ae10827f6462652a469eb52ec00106a41ee472bbd202c39da7a9b85772f329c2d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c7d1f9975d1c4ff4b99a00178e14c9ce4d64c976c4f4f4a7ed9da32a3790aa37d828060a68d1c1c59ca446024a2099f68f4c3ed15659c07f7b2fbbfd688cf6ec"} 12:35:11 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:35:11 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:35:11 INFO - Contents: 12:35:11 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/93fd49a58f87f833d9fc5bfc5f3ba6ed4d9af3a8970b1efca6febeffa6f0c15ae10827f6462652a469eb52ec00106a41ee472bbd202c39da7a9b85772f329c2d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c7d1f9975d1c4ff4b99a00178e14c9ce4d64c976c4f4f4a7ed9da32a3790aa37d828060a68d1c1c59ca446024a2099f68f4c3ed15659c07f7b2fbbfd688cf6ec"} 12:35:11 INFO - Running post-run listener: copy_logs_to_upload_dir 12:35:11 INFO - Copying logs to upload dir... 12:35:11 INFO - mkdir: /builds/slave/test/build/upload/logs 12:35:11 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1256.648798 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2016-04-14 12:35:11.492653) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-14 12:35:11.496745) ========= 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=5cf47e208febbcd81da23b2e0000026f-1460659021.283918-452146743 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/93fd49a58f87f833d9fc5bfc5f3ba6ed4d9af3a8970b1efca6febeffa6f0c15ae10827f6462652a469eb52ec00106a41ee472bbd202c39da7a9b85772f329c2d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c7d1f9975d1c4ff4b99a00178e14c9ce4d64c976c4f4f4a7ed9da32a3790aa37d828060a68d1c1c59ca446024a2099f68f4c3ed15659c07f7b2fbbfd688cf6ec"} build_url:https://queue.taskcluster.net/v1/task/O13gFoQRTV-lV4uQZhnW3A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011427 build_url: 'https://queue.taskcluster.net/v1/task/O13gFoQRTV-lV4uQZhnW3A/artifacts/public/build/firefox-48.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/93fd49a58f87f833d9fc5bfc5f3ba6ed4d9af3a8970b1efca6febeffa6f0c15ae10827f6462652a469eb52ec00106a41ee472bbd202c39da7a9b85772f329c2d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c7d1f9975d1c4ff4b99a00178e14c9ce4d64c976c4f4f4a7ed9da32a3790aa37d828060a68d1c1c59ca446024a2099f68f4c3ed15659c07f7b2fbbfd688cf6ec"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-14 12:35:11.522330) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 12:35:11.522679) ========= 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=5cf47e208febbcd81da23b2e0000026f-1460659021.283918-452146743 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004525 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 12:35:11.606283) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-14 12:35:11.606601) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-14 12:35:11.606913) ========= ========= Total master_lag: 0.18 =========