builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-047 starttime: 1461078087.52 results: success (0) buildid: 20160419053037 builduid: c508cf4b6df74bb99fd85e89c51fe763 revision: 6b2350929cdb675daf16baedf10e06f2dff008fb ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-19 08:01:27.517254) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-19 08:01:27.517729) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-19 08:01:27.518006) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-19 08:01:27.534744) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-19 08:01:27.535086) ========= 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=03627c79f6bb3d1578c4a402000001ba-1461075624.734061-793787237 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-19 08:01:27-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.3M=0s 2016-04-19 08:01:27 (46.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.098275 ========= master_lag: 0.56 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-19 08:01:28.190302) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-19 08:01:28.190632) ========= 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=03627c79f6bb3d1578c4a402000001ba-1461075624.734061-793787237 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018646 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-19 08:01:28.221010) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-19 08:01:28.221378) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 6b2350929cdb675daf16baedf10e06f2dff008fb --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 6b2350929cdb675daf16baedf10e06f2dff008fb --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=03627c79f6bb3d1578c4a402000001ba-1461075624.734061-793787237 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-19 08:01:28,502 truncating revision to first 12 chars 2016-04-19 08:01:28,502 Setting DEBUG logging. 2016-04-19 08:01:28,502 attempt 1/10 2016-04-19 08:01:28,502 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/6b2350929cdb?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-19 08:01:28,775 unpacking tar archive at: fx-team-6b2350929cdb/testing/mozharness/ program finished with exit code 0 elapsedTime=0.562069 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-19 08:01:28.796408) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-19 08:01:28.796716) ========= script_repo_revision: 6b2350929cdb675daf16baedf10e06f2dff008fb ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-19 08:01:28.797119) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-19 08:01:28.797387) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-19 08:01:28.807049) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 30 secs) (at 2016-04-19 08:01:28.807443) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=03627c79f6bb3d1578c4a402000001ba-1461075624.734061-793787237 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:01:29 INFO - MultiFileLogger online at 20160419 08:01:29 in /builds/slave/test 08:01:29 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 08:01:29 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:01:29 INFO - {'append_to_log': False, 08:01:29 INFO - 'base_work_dir': '/builds/slave/test', 08:01:29 INFO - 'blob_upload_branch': 'Fx-Team', 08:01:29 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:01:29 INFO - 'branch': 'Fx-Team', 08:01:29 INFO - 'buildbot_json_path': 'buildprops.json', 08:01:29 INFO - 'config_files': ('talos/linux_config.py',), 08:01:29 INFO - 'default_actions': ('clobber', 08:01:29 INFO - 'read-buildbot-config', 08:01:29 INFO - 'download-and-extract', 08:01:29 INFO - 'populate-webroot', 08:01:29 INFO - 'create-virtualenv', 08:01:29 INFO - 'install', 08:01:29 INFO - 'run-tests'), 08:01:29 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:01:29 INFO - 'download_minidump_stackwalk': True, 08:01:29 INFO - 'download_symbols': 'ondemand', 08:01:29 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:01:29 INFO - 'tooltool.py': '/tools/tooltool.py', 08:01:29 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:01:29 INFO - '/tools/misc-python/virtualenv.py')}, 08:01:29 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:01:29 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:01:29 INFO - 'installer_path': 'installer.exe', 08:01:29 INFO - 'log_level': 'info', 08:01:29 INFO - 'log_name': 'talos', 08:01:29 INFO - 'log_to_console': True, 08:01:29 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:01:29 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:01:29 INFO - 'opt_config_files': (), 08:01:29 INFO - 'pip_index': False, 08:01:29 INFO - 'sps_profile': False, 08:01:29 INFO - 'sps_profile_interval': 0, 08:01:29 INFO - 'suite': 'dromaeojs', 08:01:29 INFO - 'system_bits': '32', 08:01:29 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:01:29 INFO - 'title': 'talos-linux64-ix-047', 08:01:29 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:01:29 INFO - 'use_talos_json': True, 08:01:29 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:01:29 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:01:29 INFO - 'work_dir': 'build'} 08:01:29 INFO - ##### 08:01:29 INFO - ##### Running clobber step. 08:01:29 INFO - ##### 08:01:29 INFO - Running pre-action listener: _resource_record_pre_action 08:01:29 INFO - Running main action method: clobber 08:01:29 INFO - rmtree: /builds/slave/test/build 08:01:29 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:01:29 INFO - Running post-action listener: _resource_record_post_action 08:01:29 INFO - ##### 08:01:29 INFO - ##### Running read-buildbot-config step. 08:01:29 INFO - ##### 08:01:29 INFO - Running pre-action listener: _resource_record_pre_action 08:01:29 INFO - Running main action method: read_buildbot_config 08:01:29 INFO - Using buildbot properties: 08:01:29 INFO - { 08:01:29 INFO - "project": "", 08:01:29 INFO - "product": "firefox", 08:01:29 INFO - "script_repo_revision": "production", 08:01:29 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 08:01:29 INFO - "repository": "", 08:01:29 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 08:01:29 INFO - "buildid": "20160419053037", 08:01:29 INFO - "pgo_build": "True", 08:01:29 INFO - "basedir": "/builds/slave/test", 08:01:29 INFO - "buildnumber": 44, 08:01:29 INFO - "slavename": "talos-linux64-ix-047", 08:01:29 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 08:01:29 INFO - "platform": "ubuntu64_hw", 08:01:29 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 08:01:29 INFO - "branch": "fx-team", 08:01:29 INFO - "repo_path": "integration/fx-team", 08:01:29 INFO - "revision": "6b2350929cdb675daf16baedf10e06f2dff008fb", 08:01:29 INFO - "stage_platform": "linux64-pgo", 08:01:29 INFO - "builduid": "c508cf4b6df74bb99fd85e89c51fe763", 08:01:29 INFO - "slavebuilddir": "test" 08:01:29 INFO - } 08:01:29 INFO - Found installer url https://queue.taskcluster.net/v1/task/IJo0AJqER7SqedWTOTAQCQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 08:01:29 INFO - Running post-action listener: _resource_record_post_action 08:01:29 INFO - ##### 08:01:29 INFO - ##### Running download-and-extract step. 08:01:29 INFO - ##### 08:01:29 INFO - Running pre-action listener: _resource_record_pre_action 08:01:29 INFO - Running main action method: download_and_extract 08:01:29 INFO - mkdir: /builds/slave/test/build/tests 08:01:29 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')]} 08:01:29 INFO - https://queue.taskcluster.net/v1/task/IJo0AJqER7SqedWTOTAQCQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 08:01:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IJo0AJqER7SqedWTOTAQCQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 08:01:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IJo0AJqER7SqedWTOTAQCQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 08:01:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IJo0AJqER7SqedWTOTAQCQ/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 08:01:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IJo0AJqER7SqedWTOTAQCQ/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 08:01:30 INFO - Downloaded 1361 bytes. 08:01:30 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 08:01:30 INFO - Using the following test package requirements: 08:01:30 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 08:01:30 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:01:30 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:01:30 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:01:30 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 08:01:30 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:01:30 INFO - u'jsshell-linux-x86_64.zip'], 08:01:30 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:01:30 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:01:30 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 08:01:30 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:01:30 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:01:30 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:01:30 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:01:30 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:01:30 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:01:30 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:01:30 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:01:30 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:01:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:01:30 INFO - https://queue.taskcluster.net/v1/task/IJo0AJqER7SqedWTOTAQCQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:01:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IJo0AJqER7SqedWTOTAQCQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 08:01:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IJo0AJqER7SqedWTOTAQCQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 08:01:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IJo0AJqER7SqedWTOTAQCQ/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 08:01:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IJo0AJqER7SqedWTOTAQCQ/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 08:01:32 INFO - Downloaded 23782187 bytes. 08:01:32 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'] 08:01:32 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 08:01:33 INFO - Return code: 0 08:01:33 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 08:01:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:01:33 INFO - https://queue.taskcluster.net/v1/task/IJo0AJqER7SqedWTOTAQCQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:01:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IJo0AJqER7SqedWTOTAQCQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 08:01:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IJo0AJqER7SqedWTOTAQCQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 08:01:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IJo0AJqER7SqedWTOTAQCQ/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 08:01:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IJo0AJqER7SqedWTOTAQCQ/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 08:01:36 INFO - Downloaded 23782187 bytes. 08:01:36 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'] 08:01:36 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 08:01:38 INFO - Return code: 0 08:01:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:01:38 INFO - https://queue.taskcluster.net/v1/task/IJo0AJqER7SqedWTOTAQCQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 08:01:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IJo0AJqER7SqedWTOTAQCQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 08:01:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IJo0AJqER7SqedWTOTAQCQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 08:01:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IJo0AJqER7SqedWTOTAQCQ/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 08:01:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IJo0AJqER7SqedWTOTAQCQ/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 08:01:38 INFO - Downloaded 10845952 bytes. 08:01:38 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'] 08:01:38 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 08:01:39 INFO - Return code: 0 08:01:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:01:39 INFO - https://queue.taskcluster.net/v1/task/IJo0AJqER7SqedWTOTAQCQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 08:01:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IJo0AJqER7SqedWTOTAQCQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 08:01:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IJo0AJqER7SqedWTOTAQCQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 08:01:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IJo0AJqER7SqedWTOTAQCQ/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 08:01:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IJo0AJqER7SqedWTOTAQCQ/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 08:01:40 INFO - Downloaded 58271261 bytes. 08:01:40 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/IJo0AJqER7SqedWTOTAQCQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 08:01:40 INFO - mkdir: /builds/slave/test/properties 08:01:40 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:01:40 INFO - Writing to file /builds/slave/test/properties/build_url 08:01:40 INFO - Contents: 08:01:40 INFO - build_url:https://queue.taskcluster.net/v1/task/IJo0AJqER7SqedWTOTAQCQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 08:01:41 INFO - Running post-action listener: _resource_record_post_action 08:01:41 INFO - Running post-action listener: set_extra_try_arguments 08:01:41 INFO - ##### 08:01:41 INFO - ##### Running populate-webroot step. 08:01:41 INFO - ##### 08:01:41 INFO - Running pre-action listener: _resource_record_pre_action 08:01:41 INFO - Running main action method: populate_webroot 08:01:41 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:01:41 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:01:41 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:01:41 INFO - '--tppagecycles', 08:01:41 INFO - '7'], 08:01:41 INFO - 'tests': ['tsvgm']}}, 08:01:41 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:01:41 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:01:41 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:01:41 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:01:41 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:01:41 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:01:41 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:01:41 INFO - 'talos_options': ['--disable-e10s'], 08:01:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:01:41 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:01:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:01:41 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:01:41 INFO - 'talos_options': ['--disable-e10s'], 08:01:41 INFO - 'tests': ['damp', 'tps']}, 08:01:41 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:01:41 INFO - 'tests': ['damp', 'tps']}, 08:01:41 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:01:41 INFO - 'tests': ['dromaeo_dom']}, 08:01:41 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:01:41 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:01:41 INFO - 'tests': ['a11yr', 08:01:41 INFO - 'ts_paint', 08:01:41 INFO - 'tpaint', 08:01:41 INFO - 'sessionrestore', 08:01:41 INFO - 'sessionrestore_no_auto_restore', 08:01:41 INFO - 'tabpaint']}, 08:01:41 INFO - 'other-e10s': {'tests': ['a11yr', 08:01:41 INFO - 'ts_paint', 08:01:41 INFO - 'tpaint', 08:01:41 INFO - 'sessionrestore', 08:01:41 INFO - 'sessionrestore_no_auto_restore', 08:01:41 INFO - 'tabpaint']}, 08:01:41 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:01:41 INFO - 'ts_paint', 08:01:41 INFO - 'tpaint', 08:01:41 INFO - 'sessionrestore', 08:01:41 INFO - 'sessionrestore_no_auto_restore', 08:01:41 INFO - 'tabpaint']}, 08:01:41 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:01:41 INFO - 'ts_paint', 08:01:41 INFO - 'tpaint', 08:01:41 INFO - 'sessionrestore', 08:01:41 INFO - 'sessionrestore_no_auto_restore', 08:01:41 INFO - 'tabpaint']}, 08:01:41 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:01:41 INFO - 'tests': ['a11yr', 08:01:41 INFO - 'ts_paint', 08:01:41 INFO - 'tpaint', 08:01:41 INFO - 'sessionrestore', 08:01:41 INFO - 'sessionrestore_no_auto_restore', 08:01:41 INFO - 'tabpaint']}, 08:01:41 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:01:41 INFO - 'tests': ['a11yr', 08:01:41 INFO - 'ts_paint', 08:01:41 INFO - 'tpaint', 08:01:41 INFO - 'sessionrestore', 08:01:41 INFO - 'sessionrestore_no_auto_restore', 08:01:41 INFO - 'tabpaint']}, 08:01:41 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:01:41 INFO - 'tests': ['tsvgx', 08:01:41 INFO - 'tsvgr_opacity', 08:01:41 INFO - 'tart', 08:01:41 INFO - 'tscrollx', 08:01:41 INFO - 'cart']}, 08:01:41 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:01:41 INFO - 'tsvgr_opacity', 08:01:41 INFO - 'tart', 08:01:41 INFO - 'tscrollx', 08:01:41 INFO - 'cart']}, 08:01:41 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:01:41 INFO - 'talos_options': ['--disable-e10s'], 08:01:41 INFO - 'tests': ['tp5o']}, 08:01:41 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:01:41 INFO - 'tests': ['tp5o']}, 08:01:41 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:01:41 INFO - 'talos_options': ['--disable-e10s', 08:01:41 INFO - '--xperf_path', 08:01:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:01:41 INFO - 'tests': ['tp5n']}, 08:01:41 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:01:41 INFO - 'talos_options': ['--xperf_path', 08:01:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:01:41 INFO - 'tests': ['tp5n']}}, 08:01:41 INFO - 'talos.zip': {'path': '', 08:01:41 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:01:41 INFO - Running post-action listener: _resource_record_post_action 08:01:41 INFO - ##### 08:01:41 INFO - ##### Running create-virtualenv step. 08:01:41 INFO - ##### 08:01:41 INFO - Running pre-action listener: _resource_record_pre_action 08:01:41 INFO - Running main action method: create_virtualenv 08:01:41 INFO - Creating virtualenv /builds/slave/test/build/venv 08:01:41 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 08:01:41 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:01:41 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:01:41 INFO - Using real prefix '/usr' 08:01:41 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:01:41 INFO - Installing distribute.............................................................................................................................................................................................done. 08:01:43 INFO - Installing pip.................done. 08:01:43 INFO - Return code: 0 08:01:43 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:01: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')]} 08:01:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:01:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:01: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')]} 08:01:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:01:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:01: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 0x7f9a12f94f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27ac9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x283b810>, '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 0x283c710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x283cba0>, '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': '03627c79f6bb3d1578c4a402000001ba-1461075624.734061-793787237', '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 08:01: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 08:01: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 08:01:43 INFO - Using env: {'DISPLAY': ':0', 08:01:43 INFO - 'HOME': '/home/cltbld', 08:01:43 INFO - 'LANG': 'en_US.UTF-8', 08:01:43 INFO - 'LANGUAGE': 'en_US:en', 08:01:43 INFO - 'LOGNAME': 'cltbld', 08:01:43 INFO - 'MAIL': '/var/mail/cltbld', 08:01:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:01:43 INFO - 'MOZ_NO_REMOTE': '1', 08:01:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:01:43 INFO - 'NO_EM_RESTART': '1', 08:01:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:01:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:01:43 INFO - 'PWD': '/builds/slave/test', 08:01:43 INFO - 'SHELL': '/bin/bash', 08:01:43 INFO - 'SHLVL': '1', 08:01:43 INFO - 'TERM': 'linux', 08:01:43 INFO - 'TMOUT': '86400', 08:01:43 INFO - 'USER': 'cltbld', 08:01:43 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1461075624.734061-793787237', 08:01:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:01:43 INFO - '_': '/tools/buildbot/bin/python'} 08:01:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:01:44 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 08:01:44 INFO - Cleaning up... 08:01:44 INFO - Return code: 0 08:01:44 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 08:01:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:01:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:01:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:01:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:01:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:01:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:01:44 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 0x7f9a12f94f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27ac9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x283b810>, '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 0x283c710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x283cba0>, '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': '03627c79f6bb3d1578c4a402000001ba-1461075624.734061-793787237', '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 08:01:44 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 08:01:44 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 08:01:44 INFO - Using env: {'DISPLAY': ':0', 08:01:44 INFO - 'HOME': '/home/cltbld', 08:01:44 INFO - 'LANG': 'en_US.UTF-8', 08:01:44 INFO - 'LANGUAGE': 'en_US:en', 08:01:44 INFO - 'LOGNAME': 'cltbld', 08:01:44 INFO - 'MAIL': '/var/mail/cltbld', 08:01:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:01:44 INFO - 'MOZ_NO_REMOTE': '1', 08:01:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:01:44 INFO - 'NO_EM_RESTART': '1', 08:01:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:01:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:01:44 INFO - 'PWD': '/builds/slave/test', 08:01:44 INFO - 'SHELL': '/bin/bash', 08:01:44 INFO - 'SHLVL': '1', 08:01:44 INFO - 'TERM': 'linux', 08:01:44 INFO - 'TMOUT': '86400', 08:01:44 INFO - 'USER': 'cltbld', 08:01:44 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1461075624.734061-793787237', 08:01:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:01:44 INFO - '_': '/tools/buildbot/bin/python'} 08:01:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:01:44 INFO - Downloading/unpacking psutil>=0.7.1 08:01:44 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 08:01:44 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 08:01:44 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 08:01:44 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 08:01:44 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 08:01:44 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 08:01:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:01:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:01:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:01:46 INFO - Installing collected packages: psutil 08:01:46 INFO - Running setup.py install for psutil 08:01:46 INFO - building 'psutil._psutil_linux' extension 08:01:46 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 08:01:46 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 08:01:46 INFO - building 'psutil._psutil_posix' extension 08:01:46 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 08:01:46 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 08:01:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:01:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:01:46 INFO - Successfully installed psutil 08:01:46 INFO - Cleaning up... 08:01:46 INFO - Return code: 0 08:01:46 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 08:01: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')]} 08:01:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:01:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:01: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')]} 08:01:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:01:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:01: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 0x7f9a12f94f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27ac9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x283b810>, '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 0x283c710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x283cba0>, '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': '03627c79f6bb3d1578c4a402000001ba-1461075624.734061-793787237', '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 08:01: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 08:01: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 08:01:46 INFO - Using env: {'DISPLAY': ':0', 08:01:46 INFO - 'HOME': '/home/cltbld', 08:01:46 INFO - 'LANG': 'en_US.UTF-8', 08:01:46 INFO - 'LANGUAGE': 'en_US:en', 08:01:46 INFO - 'LOGNAME': 'cltbld', 08:01:46 INFO - 'MAIL': '/var/mail/cltbld', 08:01:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:01:46 INFO - 'MOZ_NO_REMOTE': '1', 08:01:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:01:46 INFO - 'NO_EM_RESTART': '1', 08:01:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:01:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:01:46 INFO - 'PWD': '/builds/slave/test', 08:01:46 INFO - 'SHELL': '/bin/bash', 08:01:46 INFO - 'SHLVL': '1', 08:01:46 INFO - 'TERM': 'linux', 08:01:46 INFO - 'TMOUT': '86400', 08:01:46 INFO - 'USER': 'cltbld', 08:01:46 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1461075624.734061-793787237', 08:01:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:01:46 INFO - '_': '/tools/buildbot/bin/python'} 08:01:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:01:47 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 08:01:47 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 08:01:47 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 08:01:47 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 08:01:47 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 08:01:47 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 08:01:47 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 08:01:48 INFO - Downloading mozsystemmonitor-0.0.tar.gz 08:01:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:01: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) 08:01:48 INFO - Installing collected packages: mozsystemmonitor 08:01:48 INFO - Running setup.py install for mozsystemmonitor 08:01:49 INFO - Successfully installed mozsystemmonitor 08:01:49 INFO - Cleaning up... 08:01:49 INFO - Return code: 0 08:01:49 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:01:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:01:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:01:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:01:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:01:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:01:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:01:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f9a12f94f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27ac9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x283b810>, '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 0x283c710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x283cba0>, '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': '03627c79f6bb3d1578c4a402000001ba-1461075624.734061-793787237', '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 08:01:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:01:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:01:49 INFO - Using env: {'DISPLAY': ':0', 08:01:49 INFO - 'HOME': '/home/cltbld', 08:01:49 INFO - 'LANG': 'en_US.UTF-8', 08:01:49 INFO - 'LANGUAGE': 'en_US:en', 08:01:49 INFO - 'LOGNAME': 'cltbld', 08:01:49 INFO - 'MAIL': '/var/mail/cltbld', 08:01:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:01:49 INFO - 'MOZ_NO_REMOTE': '1', 08:01:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:01:49 INFO - 'NO_EM_RESTART': '1', 08:01:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:01:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:01:49 INFO - 'PWD': '/builds/slave/test', 08:01:49 INFO - 'SHELL': '/bin/bash', 08:01:49 INFO - 'SHLVL': '1', 08:01:49 INFO - 'TERM': 'linux', 08:01:49 INFO - 'TMOUT': '86400', 08:01:49 INFO - 'USER': 'cltbld', 08:01:49 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1461075624.734061-793787237', 08:01:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:01:49 INFO - '_': '/tools/buildbot/bin/python'} 08:01:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:01:49 INFO - Downloading/unpacking blobuploader==1.2.4 08:01:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:01:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:01:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:01:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:01:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:01:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:01:51 INFO - Downloading blobuploader-1.2.4.tar.gz 08:01:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:01:51 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:01:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:01:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:01:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:01:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:01:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:01:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:01:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:01:51 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:01:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:01:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:01:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:01:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:01:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:01:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:01:51 INFO - Downloading docopt-0.6.1.tar.gz 08:01:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:01:51 INFO - Installing collected packages: blobuploader, requests, docopt 08:01:51 INFO - Running setup.py install for blobuploader 08:01:52 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:01:52 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:01:52 INFO - Running setup.py install for requests 08:01:52 INFO - Running setup.py install for docopt 08:01:52 INFO - Successfully installed blobuploader requests docopt 08:01:52 INFO - Cleaning up... 08:01:52 INFO - Return code: 0 08:01:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:01:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:01:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:01:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:01:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:01:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:01:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:01:52 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 0x7f9a12f94f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27ac9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x283b810>, '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 0x283c710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x283cba0>, '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': '03627c79f6bb3d1578c4a402000001ba-1461075624.734061-793787237', '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 08:01:52 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 08:01:52 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 08:01:52 INFO - Using env: {'DISPLAY': ':0', 08:01:52 INFO - 'HOME': '/home/cltbld', 08:01:52 INFO - 'LANG': 'en_US.UTF-8', 08:01:52 INFO - 'LANGUAGE': 'en_US:en', 08:01:52 INFO - 'LOGNAME': 'cltbld', 08:01:52 INFO - 'MAIL': '/var/mail/cltbld', 08:01:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:01:52 INFO - 'MOZ_NO_REMOTE': '1', 08:01:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:01:52 INFO - 'NO_EM_RESTART': '1', 08:01:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:01:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:01:52 INFO - 'PWD': '/builds/slave/test', 08:01:52 INFO - 'SHELL': '/bin/bash', 08:01:52 INFO - 'SHLVL': '1', 08:01:52 INFO - 'TERM': 'linux', 08:01:52 INFO - 'TMOUT': '86400', 08:01:52 INFO - 'USER': 'cltbld', 08:01:52 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1461075624.734061-793787237', 08:01:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:01:52 INFO - '_': '/tools/buildbot/bin/python'} 08:01:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:01:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:01:52 INFO - Running setup.py (path:/tmp/pip-w6fUVG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:01:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:01:52 INFO - Running setup.py (path:/tmp/pip-HOaMvW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:01:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:01:52 INFO - Running setup.py (path:/tmp/pip-JERMSX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:01:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:01:53 INFO - Running setup.py (path:/tmp/pip-QbWBth-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:01:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:01:53 INFO - Running setup.py (path:/tmp/pip-gmmUWU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:01:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:01:53 INFO - Running setup.py (path:/tmp/pip-38Dcce-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:01:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:01:53 INFO - Running setup.py (path:/tmp/pip-8oLqe2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:01:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:01:53 INFO - Running setup.py (path:/tmp/pip-Emxr5n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:01:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:01:53 INFO - Running setup.py (path:/tmp/pip-PzBYCb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:01:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:01:53 INFO - Running setup.py (path:/tmp/pip-EsOOnC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:01:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:01:53 INFO - Running setup.py (path:/tmp/pip-nwyVtA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:01:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:01:53 INFO - Running setup.py (path:/tmp/pip-cOy_U4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:01:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:01:53 INFO - Running setup.py (path:/tmp/pip-Nn2rVN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:01:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:01:53 INFO - Running setup.py (path:/tmp/pip-pf7k39-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:01:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:01:53 INFO - Running setup.py (path:/tmp/pip-FcfNZ9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:01:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:01:53 INFO - Running setup.py (path:/tmp/pip-A3QQ6C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:01:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:01:53 INFO - Running setup.py (path:/tmp/pip-xQ23_e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:01:54 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:01:54 INFO - Running setup.py install for manifestparser 08:01:54 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:01:54 INFO - Running setup.py install for mozcrash 08:01:54 INFO - Running setup.py install for mozdebug 08:01:54 INFO - Running setup.py install for mozdevice 08:01:54 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:01:54 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:01:54 INFO - Running setup.py install for mozfile 08:01:54 INFO - Running setup.py install for mozhttpd 08:01:54 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:01:54 INFO - Running setup.py install for mozinfo 08:01:54 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:01:54 INFO - Running setup.py install for mozInstall 08:01:54 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:01:54 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:01:54 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:01:54 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:01:54 INFO - Running setup.py install for mozleak 08:01:54 INFO - Running setup.py install for mozlog 08:01:55 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:01:55 INFO - Running setup.py install for moznetwork 08:01:55 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:01:55 INFO - Running setup.py install for mozprocess 08:01:55 INFO - Running setup.py install for mozprofile 08:01:55 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:01:55 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:01:55 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:01:55 INFO - Running setup.py install for mozrunner 08:01:55 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:01:55 INFO - Running setup.py install for mozscreenshot 08:01:55 INFO - Running setup.py install for moztest 08:01:55 INFO - Running setup.py install for mozversion 08:01:55 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:01:55 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:01:55 INFO - Cleaning up... 08:01:55 INFO - Return code: 0 08:01:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:01:55 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')]} 08:01:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:01:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:01:55 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')]} 08:01:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:01:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:01:55 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 0x7f9a12f94f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27ac9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x283b810>, '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 0x283c710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x283cba0>, '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': '03627c79f6bb3d1578c4a402000001ba-1461075624.734061-793787237', '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 08:01:55 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 08:01:55 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 08:01:55 INFO - Using env: {'DISPLAY': ':0', 08:01:55 INFO - 'HOME': '/home/cltbld', 08:01:55 INFO - 'LANG': 'en_US.UTF-8', 08:01:55 INFO - 'LANGUAGE': 'en_US:en', 08:01:55 INFO - 'LOGNAME': 'cltbld', 08:01:55 INFO - 'MAIL': '/var/mail/cltbld', 08:01:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:01:55 INFO - 'MOZ_NO_REMOTE': '1', 08:01:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:01:55 INFO - 'NO_EM_RESTART': '1', 08:01:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:01:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:01:55 INFO - 'PWD': '/builds/slave/test', 08:01:55 INFO - 'SHELL': '/bin/bash', 08:01:55 INFO - 'SHLVL': '1', 08:01:55 INFO - 'TERM': 'linux', 08:01:55 INFO - 'TMOUT': '86400', 08:01:55 INFO - 'USER': 'cltbld', 08:01:55 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1461075624.734061-793787237', 08:01:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:01:55 INFO - '_': '/tools/buildbot/bin/python'} 08:01:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:01:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:01:56 INFO - Running setup.py (path:/tmp/pip-9Gb5Um-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:01:56 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)) 08:01:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:01:56 INFO - Running setup.py (path:/tmp/pip-kvVZa4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:01:56 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)) 08:01:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:01:56 INFO - Running setup.py (path:/tmp/pip-qLgWsS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:01:56 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)) 08:01:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:01:56 INFO - Running setup.py (path:/tmp/pip-33HcAb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:01:56 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)) 08:01:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:01:56 INFO - Running setup.py (path:/tmp/pip-4GuvQm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:01:56 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)) 08:01:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:01:56 INFO - Running setup.py (path:/tmp/pip-RnJYrx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:01:56 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)) 08:01:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:01:56 INFO - Running setup.py (path:/tmp/pip-YSVcKR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:01:56 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)) 08:01:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:01:56 INFO - Running setup.py (path:/tmp/pip-HStcwE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:01:56 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)) 08:01:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:01:56 INFO - Running setup.py (path:/tmp/pip-dVCgXb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:01:56 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)) 08:01:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:01:56 INFO - Running setup.py (path:/tmp/pip-iQPacZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:01:56 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)) 08:01:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:01:56 INFO - Running setup.py (path:/tmp/pip-QD49aY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:01: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)) 08:01:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:01:56 INFO - Running setup.py (path:/tmp/pip-MVoE_P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:01: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)) 08:01:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:01:56 INFO - Running setup.py (path:/tmp/pip-TB4g69-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:01: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)) 08:01:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:01:56 INFO - Running setup.py (path:/tmp/pip-WJdVTM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:01:57 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)) 08:01:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:01:57 INFO - Running setup.py (path:/tmp/pip-7ueMLR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:01:57 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)) 08:01:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:01:57 INFO - Running setup.py (path:/tmp/pip-LQT468-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:01:57 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)) 08:01:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:01:57 INFO - Running setup.py (path:/tmp/pip-4hgVYS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:01:57 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)) 08:01:57 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)) 08:01:57 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)) 08:01:57 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)) 08:01:57 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)) 08:01:57 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)) 08:01:57 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:01:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:01:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:01:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:01:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:01:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:01:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:01:59 INFO - Downloading blessings-1.6.tar.gz 08:01:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:01:59 INFO - Installing collected packages: blessings 08:01:59 INFO - Running setup.py install for blessings 08:01:59 INFO - Successfully installed blessings 08:01:59 INFO - Cleaning up... 08:01:59 INFO - Return code: 0 08:01:59 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:01:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:01:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:01:59 INFO - Reading from file tmpfile_stdout 08:01:59 INFO - Current package versions: 08:01:59 INFO - argparse == 1.2.1 08:01:59 INFO - blessings == 1.6 08:01:59 INFO - blobuploader == 1.2.4 08:01:59 INFO - docopt == 0.6.1 08:01:59 INFO - manifestparser == 1.1 08:01:59 INFO - mozInstall == 1.12 08:01:59 INFO - mozcrash == 0.17 08:01:59 INFO - mozdebug == 0.1 08:01:59 INFO - mozdevice == 0.48 08:01:59 INFO - mozfile == 1.2 08:01:59 INFO - mozhttpd == 0.7 08:01:59 INFO - mozinfo == 0.9 08:01:59 INFO - mozleak == 0.1 08:01:59 INFO - mozlog == 3.1 08:01:59 INFO - moznetwork == 0.27 08:01:59 INFO - mozprocess == 0.22 08:01:59 INFO - mozprofile == 0.28 08:01:59 INFO - mozrunner == 6.11 08:01:59 INFO - mozscreenshot == 0.1 08:01:59 INFO - mozsystemmonitor == 0.0 08:01:59 INFO - moztest == 0.7 08:01:59 INFO - mozversion == 1.4 08:01:59 INFO - psutil == 3.1.1 08:01:59 INFO - requests == 1.2.3 08:01:59 INFO - wsgiref == 0.1.2 08:01:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:01: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')]} 08:01:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:01:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:01: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')]} 08:01:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:01:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:01:59 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 0x7f9a12f94f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27ac9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x283b810>, '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 0x283c710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x283cba0>, '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': '03627c79f6bb3d1578c4a402000001ba-1461075624.734061-793787237', '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 08:01:59 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 08:01:59 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 08:01:59 INFO - Using env: {'DISPLAY': ':0', 08:01:59 INFO - 'HOME': '/home/cltbld', 08:01:59 INFO - 'LANG': 'en_US.UTF-8', 08:01:59 INFO - 'LANGUAGE': 'en_US:en', 08:01:59 INFO - 'LOGNAME': 'cltbld', 08:01:59 INFO - 'MAIL': '/var/mail/cltbld', 08:01:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:01:59 INFO - 'MOZ_NO_REMOTE': '1', 08:01:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:01:59 INFO - 'NO_EM_RESTART': '1', 08:01:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:01:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:01:59 INFO - 'PWD': '/builds/slave/test', 08:01:59 INFO - 'SHELL': '/bin/bash', 08:01:59 INFO - 'SHLVL': '1', 08:01:59 INFO - 'TERM': 'linux', 08:01:59 INFO - 'TMOUT': '86400', 08:01:59 INFO - 'USER': 'cltbld', 08:01:59 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1461075624.734061-793787237', 08:01:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:01:59 INFO - '_': '/tools/buildbot/bin/python'} 08:01:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:01:59 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)) 08:01:59 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)) 08:01:59 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)) 08:01:59 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)) 08:01:59 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)) 08:01:59 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)) 08:01:59 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)) 08:01:59 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)) 08:01:59 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)) 08:01:59 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)) 08:01:59 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)) 08:01:59 INFO - Cleaning up... 08:01:59 INFO - Return code: 0 08:01:59 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:01: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')]} 08:01:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:01:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:01: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')]} 08:01:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:01:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:01: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 0x7f9a12f94f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27ac9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x283b810>, '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 0x283c710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x283cba0>, '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': '03627c79f6bb3d1578c4a402000001ba-1461075624.734061-793787237', '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 08:01: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 08:01: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 08:01:59 INFO - Using env: {'DISPLAY': ':0', 08:01:59 INFO - 'HOME': '/home/cltbld', 08:01:59 INFO - 'LANG': 'en_US.UTF-8', 08:01:59 INFO - 'LANGUAGE': 'en_US:en', 08:01:59 INFO - 'LOGNAME': 'cltbld', 08:01:59 INFO - 'MAIL': '/var/mail/cltbld', 08:01:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:01:59 INFO - 'MOZ_NO_REMOTE': '1', 08:01:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:01:59 INFO - 'NO_EM_RESTART': '1', 08:01:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:01:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:01:59 INFO - 'PWD': '/builds/slave/test', 08:01:59 INFO - 'SHELL': '/bin/bash', 08:01:59 INFO - 'SHLVL': '1', 08:01:59 INFO - 'TERM': 'linux', 08:01:59 INFO - 'TMOUT': '86400', 08:01:59 INFO - 'USER': 'cltbld', 08:01:59 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1461075624.734061-793787237', 08:01:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:01:59 INFO - '_': '/tools/buildbot/bin/python'} 08:02:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:02:00 INFO - Downloading/unpacking jsonschema 08:02:00 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 08:02:00 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 08:02:00 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 08:02:00 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 08:02:00 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 08:02:00 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 08:02:01 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:02:01 INFO - Downloading/unpacking functools32 (from jsonschema) 08:02: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 08:02: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 08:02: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 08:02: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 08:02: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 08:02: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 08:02:02 INFO - Downloading functools32-3.2.3-2.tar.gz 08:02:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:02:02 INFO - warning: no files found matching '*.txt' 08:02:02 INFO - no previously-included directories found matching 'build' 08:02:02 INFO - no previously-included directories found matching 'dist' 08:02:02 INFO - no previously-included directories found matching '.git*' 08:02:02 INFO - Installing collected packages: jsonschema, functools32 08:02:02 INFO - Running setup.py install for functools32 08:02:02 INFO - warning: no files found matching '*.txt' 08:02:02 INFO - no previously-included directories found matching 'build' 08:02:02 INFO - no previously-included directories found matching 'dist' 08:02:02 INFO - no previously-included directories found matching '.git*' 08:02:02 INFO - Successfully installed jsonschema functools32 08:02:02 INFO - Cleaning up... 08:02:02 INFO - Return code: 0 08:02:02 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 08:02:02 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')]} 08:02:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:02:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:02:02 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')]} 08:02:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:02:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:02:02 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 0x7f9a12f94f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27ac9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x283b810>, '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 0x283c710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x283cba0>, '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': '03627c79f6bb3d1578c4a402000001ba-1461075624.734061-793787237', '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 08:02:02 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 08:02:02 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 08:02:02 INFO - Using env: {'DISPLAY': ':0', 08:02:02 INFO - 'HOME': '/home/cltbld', 08:02:02 INFO - 'LANG': 'en_US.UTF-8', 08:02:02 INFO - 'LANGUAGE': 'en_US:en', 08:02:02 INFO - 'LOGNAME': 'cltbld', 08:02:02 INFO - 'MAIL': '/var/mail/cltbld', 08:02:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:02:02 INFO - 'MOZ_NO_REMOTE': '1', 08:02:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:02:02 INFO - 'NO_EM_RESTART': '1', 08:02:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:02:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:02:02 INFO - 'PWD': '/builds/slave/test', 08:02:02 INFO - 'SHELL': '/bin/bash', 08:02:02 INFO - 'SHLVL': '1', 08:02:02 INFO - 'TERM': 'linux', 08:02:02 INFO - 'TMOUT': '86400', 08:02:02 INFO - 'USER': 'cltbld', 08:02:02 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1461075624.734061-793787237', 08:02:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:02:02 INFO - '_': '/tools/buildbot/bin/python'} 08:02:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:02:02 INFO - Downloading/unpacking flake8 08:02:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:02:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:02:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:02:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:02:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:02:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:02:04 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 08:02:04 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 08:02: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 08:02: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 08:02: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 08:02: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 08:02: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 08:02: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 08:02:04 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 08:02:04 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 08:02: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 08:02: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 08:02: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 08:02: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 08:02: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 08:02: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 08:02:04 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 08:02: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 08:02: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 08:02: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 08:02: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 08:02: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 08:02: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 08:02:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 08:02:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:02:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:02:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:02:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:02:05 INFO - no previously-included directories found matching 'docs/_build' 08:02:05 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 08:02:05 INFO - Running setup.py install for pep8 08:02:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:02:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:02:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:02:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:02:05 INFO - no previously-included directories found matching 'docs/_build' 08:02:05 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 08:02:05 INFO - Successfully installed flake8 mccabe pyflakes pep8 08:02:05 INFO - Cleaning up... 08:02:05 INFO - Return code: 0 08:02:05 INFO - Running post-action listener: _resource_record_post_action 08:02:05 INFO - Running post-action listener: _start_resource_monitoring 08:02:05 INFO - Starting resource monitoring. 08:02:05 INFO - ##### 08:02:05 INFO - ##### Running install step. 08:02:05 INFO - ##### 08:02:05 INFO - Running pre-action listener: _resource_record_pre_action 08:02:05 INFO - Running main action method: install 08:02:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:02:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:02:05 INFO - Reading from file tmpfile_stdout 08:02:05 INFO - Detecting whether we're running mozinstall >=1.0... 08:02:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:02:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:02:05 INFO - Reading from file tmpfile_stdout 08:02:05 INFO - Output received: 08:02:05 INFO - Usage: mozinstall [options] installer 08:02:05 INFO - Options: 08:02:05 INFO - -h, --help show this help message and exit 08:02:05 INFO - -d DEST, --destination=DEST 08:02:05 INFO - Directory to install application into. [default: 08:02:05 INFO - "/builds/slave/test"] 08:02:05 INFO - --app=APP Application being installed. [default: firefox] 08:02:05 INFO - mkdir: /builds/slave/test/build/application 08:02:05 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'] 08:02:05 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 08:02:22 INFO - Reading from file tmpfile_stdout 08:02:22 INFO - Output received: 08:02:22 INFO - /builds/slave/test/build/application/firefox/firefox 08:02:22 INFO - Running post-action listener: _resource_record_post_action 08:02:22 INFO - ##### 08:02:22 INFO - ##### Running run-tests step. 08:02:22 INFO - ##### 08:02:22 INFO - Running pre-action listener: _resource_record_pre_action 08:02:22 INFO - Running main action method: run_tests 08:02:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:02:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:02:22 INFO - Python 2.7.3 08:02:22 INFO - Return code: 0 08:02:22 INFO - grabbing minidump binary from tooltool 08:02:22 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')]} 08:02:22 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 0x283b810>, '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 0x283c710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x283cba0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:02:22 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 08:02:22 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 08:02:22 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:02:22 INFO - Return code: 0 08:02:22 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:02:22 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:02:22 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:02:22 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:02:22 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:02:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 08:02:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 08:02:23 INFO - Return code: 0 08:02:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IJo0AJqER7SqedWTOTAQCQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-047', '--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 08:02:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/IJo0AJqER7SqedWTOTAQCQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-047 --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 08:02:23 INFO - Using env: {'DISPLAY': ':0', 08:02:23 INFO - 'HOME': '/home/cltbld', 08:02:23 INFO - 'LANG': 'en_US.UTF-8', 08:02:23 INFO - 'LANGUAGE': 'en_US:en', 08:02:23 INFO - 'LOGNAME': 'cltbld', 08:02:23 INFO - 'MAIL': '/var/mail/cltbld', 08:02:23 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:02:23 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:02:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:02:23 INFO - 'MOZ_NO_REMOTE': '1', 08:02:23 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:02:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:02:23 INFO - 'NO_EM_RESTART': '1', 08:02:23 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:02:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:02:23 INFO - 'PWD': '/builds/slave/test', 08:02:23 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:02:23 INFO - 'SHELL': '/bin/bash', 08:02:23 INFO - 'SHLVL': '1', 08:02:23 INFO - 'TERM': 'linux', 08:02:23 INFO - 'TMOUT': '86400', 08:02:23 INFO - 'USER': 'cltbld', 08:02:23 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1461075624.734061-793787237', 08:02:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:02:23 INFO - '_': '/tools/buildbot/bin/python'} 08:02:23 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IJo0AJqER7SqedWTOTAQCQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-047', '--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 08:02:24 INFO - mozversion application_buildid: 20160419053037 08:02:24 INFO - mozversion application_changeset: 6b2350929cdb675daf16baedf10e06f2dff008fb 08:02:24 INFO - mozversion application_display_name: Nightly 08:02:24 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:02:24 INFO - mozversion application_name: Firefox 08:02:24 INFO - mozversion application_remotingname: firefox 08:02:24 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 08:02:24 INFO - mozversion application_vendor: Mozilla 08:02:24 INFO - mozversion application_version: 48.0a1 08:02:24 INFO - mozversion platform_buildid: 20160419053037 08:02:24 INFO - mozversion platform_changeset: 6b2350929cdb675daf16baedf10e06f2dff008fb 08:02:24 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 08:02:24 INFO - mozversion platform_version: 48.0a1 08:02:24 INFO - using testdate: 1461078144 08:02:24 INFO - actual date: 1461078144 08:02:24 INFO - starting webserver on 'localhost:54822' 08:02:24 INFO - SUITE-START | Running 2 tests 08:02:24 INFO - TEST-START | dromaeo_css 08:02:24 INFO - operating with platform_type : linux_ 08:02:24 INFO - Initialising browser for dromaeo_css test... 08:02:24 INFO - TEST-INFO | started process 15422 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgzKwHE/profile http://localhost:54822/getInfo.html) 08:02:28 INFO - PROCESS | 15422 | __metrics Screen width/height:1600/1200 08:02:28 INFO - PROCESS | 15422 | colorDepth:24 08:02:28 INFO - PROCESS | 15422 | Browser inner width/height: 1024/697 08:02:28 INFO - PROCESS | 15422 | __metrics 08:02:28 ERROR - PROCESS | 15422 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 08:02:29 INFO - TEST-INFO | 15422: exit 0 08:02:29 INFO - Browser initialized. 08:02:29 INFO - Running cycle 1/1 for dromaeo_css test... 08:02:29 INFO - TEST-INFO | started process 15503 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgzKwHE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:02:41 INFO - PROCESS | 15503 | RSS: Main: 152829952 08:02:41 INFO - PROCESS | 15503 | 08:03:32 INFO - PROCESS | 15503 | 1461078212492 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] 08:05:39 INFO - PROCESS | 15503 | Cycle 1(1): loaded http://localhost:54822/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54822/tests/dromaeo/cssquery-ext.html) 08:05:40 INFO - PROCESS | 15503 | RSS: Main: 248107008 08:05:40 INFO - PROCESS | 15503 | 08:08:43 INFO - PROCESS | 15503 | Cycle 1(1): loaded http://localhost:54822/tests/dromaeo/cssquery-ext.html (next: http://localhost:54822/tests/dromaeo/cssquery-jquery.html) 08:08:43 INFO - PROCESS | 15503 | RSS: Main: 232574976 08:08:43 INFO - PROCESS | 15503 | 08:11:45 INFO - PROCESS | 15503 | Cycle 1(1): loaded http://localhost:54822/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54822/tests/dromaeo/cssquery-mootools.html) 08:11:46 INFO - PROCESS | 15503 | RSS: Main: 240193536 08:11:46 INFO - PROCESS | 15503 | 08:14:48 INFO - PROCESS | 15503 | Cycle 1(1): loaded http://localhost:54822/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54822/tests/dromaeo/cssquery-prototype.html) 08:14:48 INFO - PROCESS | 15503 | RSS: Main: 229130240 08:14:48 INFO - PROCESS | 15503 | 08:17:51 INFO - PROCESS | 15503 | Cycle 1(1): loaded http://localhost:54822/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54822/tests/dromaeo/cssquery-yui.html) 08:17:51 INFO - PROCESS | 15503 | RSS: Main: 223559680 08:17:51 INFO - PROCESS | 15503 | 08:20:54 INFO - PROCESS | 15503 | Cycle 1(1): loaded http://localhost:54822/tests/dromaeo/cssquery-yui.html (next: http://localhost:54822/tests/dromaeo/cssquery-dojo.html) 08:20:54 INFO - PROCESS | 15503 | RSS: Main: 268062720 08:20:54 INFO - PROCESS | 15503 | 08:20:54 INFO - PROCESS | 15503 | __start_tp_report 08:20:54 INFO - PROCESS | 15503 | _x_x_mozilla_page_load 08:20:54 INFO - PROCESS | 15503 | _x_x_mozilla_page_load_details 08:20:54 INFO - PROCESS | 15503 | |i|pagename|runs| 08:20:54 INFO - PROCESS | 15503 | |0;dojo.html;2988;3053.4045861057075;3081.3067059911523;3084.3985422842543;3110.7977981431213;5150.613703972208;5226.817061402851;5228.686278823268;5249.947500524993;5275.182346736257;5241.790328386869;5269.156934890419;5352.357717073947;5352.464753524655;5355.892882142355;4724.102420540086;4775.188218002931;4834.081524510332;4869.342638743778;4925.039617274633;4838.395200599925;4869.878253043685;4899.314096026559;4911.950880491185;4920.449903862436;4698.154332220199;4718.740469274188;4777.283407488904;4815.711057336536;4821.493743156988;4799.856004319841;4817.3737414136285;4828.0585285869265;4842.031593681243;4856.05306965142;4640.976795116003;4780;4793.18515852306;4799.664023518355;4817.470078291385;5159.587233021387;5206.635535512516;5228.607854410934;5256.81601143962;5273.789048438058;5653.830385088413;5660.660360378391;5691.032524470808;5691.146328050825;5697.287839020122;5524.33707955048;5566.415526369713;5698.116791897262;5718.228039214736;5723;5277.261183434322;5294.258803767514;5296.549793267538;5322.840314790524;5338.893222135535;5798.246227990418;5803.9419605803405;5805.82582522525;5807.738651760681;5809.215755872903;5366.329208848894;5453.127499600045;5533.750981205855;5536.141898005815;5542.972285138549;5592.049351610236;5593.496585307342;5598.664080155204;5601.215829783833;5629.099344104923;5562.443755624486;5567.638103523258;5568.805091821767;5572.219889215513;5575.832725018256;5497.367802702661;5548.750306236229;5589.450698806206;5652.660840349592;5690.487856092972;4196.223698615766;4197.055662475918;4197.559256278108;4197.601227883346;4236.894077648083;3804.9239015220096;3815.6756675682323;3825.0819803247578;3828.5979972103087;3845.6346647068485;5256.474352564713;5267.394249661262;5335.573154147659;5357.19642053695;5362.329708786402;5616.66300022;5626.324841019022;5628.212050312877;5637.46444087811;5651.095824668033;5283.788648454019;5293.258943747878;5308.893822123536;5313.521783039545;5357.732113394315;4593.839215627504;4672;4672.392588963413;4769.42766867978;4771.308160316735;5823.388544202882;5825.854353641193;5831.620944638585;5851.795187168514;5852.502537284378;5645.4072322405555;5656.23640808502;5658.688772117573;5660.830175094754;5664.376918538875;5746.080627099811;5756.30924289088;5825.76696932118;5863.765449381977;5870.53035757147;5566.526845218202;5566.916496252478;5573.6098473106495;5581.860453488533;5582.27430434041;5499.395066542597;5643.633163844337;5649.209110724584;5649.604527683023;5651.660900345993;5426.864328391822;5469.699166545878;5470.398256191736;5500.9174862377895;5519.586031047607;5465.070937940639;5465.617406781487;5480.150576660624;5488.69812160319;5496.203050557727;5328.307320048369;5346.331708536433;5372.973135134299;5401.810936617199;5446.128619421032;5528.55771538284;5539.584531160099;5549.389567147691;5561.221429000024;5614.101743720985;5398.946010539844;5439.184122381675;5439.401665816836;5441.5374693151525;5482.013237617267 08:20:54 INFO - PROCESS | 15503 | |1;ext.html;611.3428064830306;641.7978336823898;650.9934900650993;656.1109696361433;667.1727058447525;29905.40189196215;37352;37901.24197516055;38070.23859522808;38218.23563528728;40027.59972400275;40959;40998.795006025;41057;41088;7743.496672716284;8392.244697977181;8646.394752367336;8648.308135349189;9921.702348929544;9893.356931799446;10128.746781330488;10133.08802207801;10139.188864890792;10140.594376224943;10133.138683211935;10210.89789102107;10214.89785102147;10217.744556386113;10257.589696412135;7949.40379471539;10103.090721835033;10284.794304113952;10747.08649764771;10751;10109.949450252701;10208.081272685495;10267.589296428134;10273.229507786946;10277.126444252248;37835.24329513422;38321.23357532834;38350;38473.230535389135;38528.80735596332;3337.4326364517847;3412.3516531859113;3460.2906404187083;3466.8959931202103;3848.4804551385487;32486.675133248602;32602.673973260436;32673;32753.83623081893;33918.83040584781;4247.277962746341;4284.721493102938;4321.4935337504485;4368.956310436887;4374.825006999717;302956;303095;303413;306055;306656;58149.70925145432;60239;60367.69816150891;60378;60519.39480605138;57030.429695702514;57146.71426642923;57272.42727572671;57306.713466432404;57353;15139.924300378427;15444.613884652974;15518.844811551966;15523;15532.301046452936;12139.453724582416;12243.326617035971;12249.387530623433;12251.509939602316;12252.877471225353;17726.734098988527;17858.642827143383;17893.463196104138;17939.910300448675;17985.1007449627;5244.580433565306;6206.565540412128;6247.687615619201;6269.247690277196;6289.886506179379;1000.8448690452991;1049.501486793782;1111.0112000319723;1125.921185517006;1147.225622704671;29491.85254073716;31482;32756.344873102404;32773.83613081967;33436.331273374395;1058.4866339825178;1104.7569534702352;1114.9386783726811;1141.6346769033996;1166.2594252649628;14656.560303190921;15022;15028.323725432381;15319.770203446957;15335.156566388732;316714;321298;321789;322044.6773193616;323297;52419.73790131025;52960.735196323774;53398.46601534013;58131.709341453025;58255;1297.1438850358718;1315.8684131586956;1387.7363300972784;1420.424727985147;1511.8185817701726;28361.43277134487;30490.237744056576;30638.21310291573;31096.22259443532;33212.33575328528;46314.76842615765;46710.53289467062;46928.53071469242;47130.764346178046;47169;254350;254360;254971;255278;255491;23891;28356.43287134287;28989.420211596072;29310.12069637914;29320.853395732884;40349.79825100856;40368.596314036484;40613.39079913744;41197.79401102975;48271.75864120657;36638;36817;37027.25945481129;37395;40485.79757101196;36249.27501450009;37320.81339593285;39623.40564891587;39804.800975994935;39985.40094893822;41609.79195104005;41681;41918.371224431045;42076.78961605173;43163.115319621385;32482.35035299328;34449.48325775166;35047.72930274783;35223.82388088043;35563.644363556035;27387.86306068457;27419;27538.862305689145;27634.091994270286;27727.584086239127 08:20:54 INFO - PROCESS | 15503 | |2;jquery.html;374.1936127644925;375.4968342421155;390.1047096912585;390.5703725901509;399.4367941202905;15048.473303434383;17224.13879306036;17249.65500689987;18818.90590547049;18821.153048112832;17575.91212043938;17578.64842703145;18392.44822655319;18398.540036499093;19196.42410727677;5485.780568777254;5652.236948012007;5669.659820410789;5698.6865722385255;5708.771649134051;5537.972310138463;5613.775448982035;5662.801801936933;5663.8584035399235;5668.206451096829;5475.288212532365;5625.8593535161535;5632.577556683244;5637.436256374371;5642.774289028454;5174.637775355726;5526.861828454281;5537;5549.528290095326;5560.749766260528;5258.526732594085;5330.631920913825;5368.543673787733;5369.0604144274985;5369.140937449989;22184;22317;22356.21753238645;22520.324390268153;22959.311220663407;2158.9568208635737;2268.2514770125817;2401.6997875265592;2942.6174597302215;2957.142428695676;9580.61677532898;9699;10101.797964040677;10252.846207306897;14375.640608984755;1738.4610770661136;1788.5975655477544;1799.6040871008356;1834;1858.8977606231651;77905.61047194785;79723;80099.19900800976;80143.5992820038;80148.59925700392;10248.897511024943;10294.948525257476;10738.624148154777;10768.192385570957;10901.672949811518;14766.778498322534;14772.335244914004;14847.70304593902;14856.851431485762;14883.586059324347;7581.810454738676;7621.6570254338685;7722.806929826799;7837.843243135106;7956.124826269106;7447.590382529013;7492.325690687864;7588.127365352944;7603.4297427693145;7632.465727399029;4450.910981780346;4515.68390212682;4548.818047278138;4570.588647021717;4615.376924115269;1814.646144001907;1830.6155707301616;1845.8892466452055;1847.8706490545533;1896.506908203877;882.8808110904946;952.9428234305964;978.1929907826072;1014.6955913226003;1077.1544337694872;17740.29038838432;18682.81317186838;18785.624287514445;18968;19086.904565477085;1009.6112996496402;1018.5212949913529;1018.5976539266948;1051.779126383468;1054.7257712994676;9977.501124943723;10702.357858528514;10732.302400343953;10765.730856728644;10805.459727013775;436610;447249;455626;457680;473167;90692.54653726821;92438.53780731054;92544.07455925489;92779;93429;995.6266400099962;1016.3850870223556;1030.6289735695143;1048.9527971241312;1051.395447617623;16049.277782500048;16421.507354779376;16458.177091145633;16701.49895503137;16957.49127526176;27128.32179195536;35839.46240806442;37032.62967370292;38448.423273650355;39940;48857.5114248853;50438.49561504338;52287;52384.738076309375;52939;8301.377396695152;8480.321574274167;8519.23326900582;8620.310375169845;8831.91168088311;9449.102335278138;10138.138258248131;10138.949305253427;12374.938125309316;13609.52366667162;11267.605633803105;11393;11398.430078496207;11437.085033197158;11600.361980091177;10816.621418250323;11160.720981975515;11374.601888933848;11659.475323610288;12128.332941687939;8528.445651032664;11304.943475282571;11323.377214253294;11515.654530364103;11685.76628467409;8187.590620469072;8187.83624327522;8338.708145214889;8782.648694052166;8795.47227166372;11159.163062770162;11166.553337866395;11225.158113141384;11352.54589816398;11445.141614379121 08:20:54 INFO - PROCESS | 15503 | |3;mootools.html;1378.6002059402774;1468.8237411510618;1515.4392874636387;1624.683186778578;1785.4286628278949;7649.388048956084;7989.081255655601;8047.879281810778;8061.677532898684;8067.677292908292;7581.772546823604;7739.419543534229;7743;7745.728899488519;7758.224177582239;1901.648195083907;1963.0577322885024;1971.3593082248256;2235.3182279404814;2274.8293877959136;2204.8236141108755;2281.0761641535205;2287.576798292313;2289.301762962296;2289.3933107726466;2221.544583360407;2245.4049676835652;2250.313654335427;2251.752307246202;2255.109231853417;1952.80471952805;2116.3016204652504;2120.162535798359;2122.4693826543366;2153.6123497770395;2231.1856172497082;2246.640537514006;2251.6284813006;2253.211376018397;2255.537614788964;7903.525788452654;7910.090339610961;7946;7968.880466793003;7988.041435027776;4449.866504004885;4621.630269578459;4645.094206629708;4649.163150632885;4662.7202367858035;3024.9848750756105;3218;3303.3888730584677;3303.653116422765;3328.384248913959;992.4789485520088;999.160705007797;1000.5997600959602;1009.369144284822;1016.7915577306634;10518.316309439939;10612.151027917747;10636.095931845803;10676.572937082507;10814.675559733221;3965.5836137205756;4019.698522610816;4169.728967617095;4178.206140833232;4215.515215750167;9307.76730581741;9315.20820730232;9315.813683726288;9324;9327.486988215713;4778.737169455644;4788.497207793202;4794.7842347094465;4807.038592281558;4814.061258054716;3954;4200.264953633102;4282.314829627245;4434.068845542408;4478.261086920622;3739.9252014960093;3751.718621103428;3820.56063552695;3833.923321533554;3839;1074.3285446595878;1205.4153735438306;1232.6055662188014;1234.3149551998727;1242.8943539799038;827.6151589510906;833.6040380819062;843.3590471241778;862.344618090256;868.1231955724763;5106.234064890296;5132.204508301219;5180.222966555047;5290.761915713802;5329.067413202752;363.4058314655557;375.21954334983167;376.6045652065321;380.4559479943707;381.96944244460377;3514.7715398499017;3552.307300076512;3558.5907620623443;3603.3333833240936;3646.1796095878744;9462.57418416173;9800.65697700577;9852.80294394108;9903.25725570585;9938.304318697621;9805.411675299505;9808.705738827846;9808.950955245178;9809.166220871162;9809.362391444532;7028.508004439743;7545.396368290523;7623.695052197961;7634.236576342321;7637.389008879276;5269.1569348903995;5308.309919710413;5314.4951229633125;5333.253344531846;5383.569314454912;8637.611307491303;8732.432391894507;8752.29981601483;8825.69110081144;8847.911520884967;8749.5187764671;8853.645854165761;8891.866622000805;8963.955180224057;8976.102389761232;6316.905246421399;6441.7116576685785;6505.642189679613;6994.930050699428;7057.294270572902;7393.667284972082;7594.734184303523;7613.162552119373;7615.352695020985;7617.124030736536;6808.251092379735;7139.821504462222;7192.352688258082;7211.350978411968;7255.310745479171;6809;6823.55646882951;6899.517033807585;6932.23745388017;7035.190953040261;6049.727762250621;6238.6880655966115;6239.78160764371;6421.454176395058;6477;4383.912321753483;4415.536368681371;4471.776411179493;4489.1470620583295;4514.68397212192;4543.068670922519;4602.677812553089;4612.723236605814;4635.768211589339;4640.164770341371 08:20:54 INFO - PROCESS | 15503 | |4;prototype.html;295.58470349159427;296.3864799864281;303.0333236974053;304.84452929006216;306.4942844306892;5634.4928956393915;5647.548196144314;5656.2929633795775;5691;5772.163036359725;5594.007206144714;5632.436756324366;5633.746481408336;5637.8590535236635;5651.32184137903;4043.7169398142214;4105.630493255607;4217.34631132175;4217.7891105444605;4260;4243.151369726052;4247.299195632717;4251.766152861592;4264.547884966141;4264.978675106636;4046.9190616187657;4231.830726770941;4235.555266696999;4240.406343111967;4243.618074373306;4140.60664236897;4230.132822771325;4258.787060646986;4260.21186080573;4265.957340426618;3687.3915803892323;3695.2609478104487;3698.2418604186346;3700.5189325387796;3722.9947914063323;5326.92009619856;5423.152844756534;5454.290942177491;5456.03582710224;5475.178723191513;4846.7576621169155;4887.095887260868;4914.950850491485;4930.235813448921;4935.407751069894;5851.531877449794;5857.7949771757785;5858.150568167592;5875.735591898375;5884.617499862496;4016.377461493473;4076.5923407658997;4082.591740825894;4100.405441211037;4110.815013324408;6109.083637454418;6129.816105516842;6151.292601350857;6185.752569897199;6191.873104082455;4117.135401565645;4139.503259608866;4166.8749937501925;4177.707560470799;4190.203861266411;4209.852655157055;4218.135282267128;4220.5146408163455;4220.831166753295;4231.174920890397;4580.862574122782;4840.75796210188;4845.53967373099;4854.902901941941;4855.295982082578;5950.107483877453;5973.223480947449;5980.671063091485;5992.221011268594;5994.100884867305;1413.5264686330195;1414.5119933622884;1434.390384086759;1436.6911114110517;1442.451868290043;880.6037283222576;922.7923717163719;926.3978414030934;934.1685899549407;949.8622699708503;5680.403557626472;5683.630564013326;5688.914666280009;5690.971545142331;5704.429557044263;6056.242969628796;6065.361567718057;6072.362401947732;6079.6960151992225;6085.9695701521205;5547.944520554824;5606.775728970795;5723.914141287884;5745.1669507921115;5766.336871259775;3240.643529211832;3254.3816674831705;3258.1365938026443;3265.4775235962134;3269.019294211727;6197.163382943335;6329.936700633027;6332.8416789579705;6338.809835704937;6367.522435817332;6198.473129783929;6213.316535181127;6216.720247588869;6226.377362263828;6232;6112.816615501453;6314.0844577536;6332.39842214998;6333.398327158912;6342.302346741854;5996.160537524837;6047.244094488189;6061.36355682647;6074.757009719562;6092.969535152296;5962.64475532171;5968.641881487125;5976.133460648269;5978.760849565969;5988.6706231157705;6112.908306375497;6303.0775613438345;6310.905336419865;6323.9683801580695;6325.746970121144;3992;4001.7999100045463;4008.0781420272915;4008.9599104008585;4022.4167495712372;5849.122631605123;6028.3971602839365;6040.275166979991;6054.638690910637;6062.333143354315;5886.175935368966;5892.970535147297;5901.439363260483;5904.439078287556;5938.138969849434;5822.796202132905;5862.355140934408;5862.882742345044;5902.350741418355;5918.73365698536;5545.334559852843;5695.174199741097;5765.682887441231;5790.973159394347;5896.14505896634;5998.25021872266;6017.428344307284;6026.306974697791;6039.275286965592;6049.939500604937;5722.4277572242445;5850.561207909339;5860.853478663067;5883;5905.498032667271 08:20:54 INFO - PROCESS | 15503 | |5;yui.html;732.7105793211681;762.9008228930238;797.3382092862925;797.3421926910298;802.8635132027555;13459.932700336496;14102.435902563899;14172;14238.145711257332;14280.428782848687;13378.331083445813;13434.261115638661;13442.39509222085;13445.126066805651;13446.058775885693;671.2817285504512;770.9498882572643;796.0884786918974;798.3692882622736;804.8189157439588;800.5156880087551;809.0372456776447;809.1503920883079;809.8582748019103;811.7199566149669;855.9101294364095;855.9186877246651;857.1342943626951;857.3826844671827;857.8241460500583;704.9154101507826;817.4604760857835;839.6137776622761;839.8656215005631;853.3343991686495;613.7882430561449;613.8741557980603;614.7110857896781;614.7387360371869;615.1848800339568;12755.872441275562;12803.743925121445;12816.731733408014;12832.358382080858;12843.614691559269;13762.449502019907;13879.097858639156;14191.077579957373;14200.218987955659;14277.857221427861;10237.641682541076;10379.42913139777;10464.947675261652;10558.472076396227;10608.20438467118;3738.1776009277914;3739.925201495982;3820.59883712209;3866.0914685048992;3972.741771784825;57910;58659.413405865824;59642;60550.697246513926;60763.392366076216;10187.08316251526;10212.693619191436;10367.585296588202;10399.94800025995;10699.786004279871;19135.23459061622;19298.517537061405;19520.414387568395;19602.90198548998;19629.901850490656;7352.485326027234;7598.468107232441;7659.425543084291;7943.602819858984;7952.920470795334;4132.359484279941;4190.245755763931;4347.739135651871;4416.80124394403;4643.187442197602;3065.417570661612;3131.765117616188;3137.8587963541695;3156.7632427568024;3157.8105313681253;560.9971950140223;575.4098928905702;590.7282649981057;596.7642781101528;598.3537779198455;671.1744554198364;694.2206133935011;697.4211404534225;698.155232169081;707.9539829911039;8490.702825401082;8659.740207793777;8894.555272236363;8904.777380565538;8996.370254082281;560.0982418306523;567.0898208375498;568.7014317483354;573.1488739222251;611.7705860302386;4172.123853990696;4209.494860616745;4238.470191226097;4297.205017071852;4367.6287515561535;66069.48371818842;66299.66850165719;67094;67144.6642766783;67333.66333168303;56204;57001.71499142478;57189.14216286759;57464.71267643635;58185;50018.99999999927;50699.746501267255;50834;50857.49142508602;51918.22122668163;8162.061362943337;8210.01479822425;8309.418340716093;8387.622556985072;8390.065494588478;34312.79905203406;34872.12819679427;35377.46933795944;35496.46755298724;35721.64278357287;47006;47008.764956175;47283.527164727915;47358.28962565495;47851;10527.315724477885;10578.471076446302;10644.148468122687;10772.569097236335;10892.727681808019;11437.828432573351;11654.53381864716;11920.284782913053;12477.376131193585;12715.745685086431;11964;12109.394530273275;12212.938935305267;12716.427760750974;12749.17130386522;12000.939995299968;12072.637820865388;12271.938640306742;12458.314792686127;12784.872151278369;11715.17993740464;12130.818037729265;12213.633590992284;12627.368631568568;12656.557020504239;10031.849522257025;10291.588336466457;10295.794084118126;10357.223208259562;10725.731856703645;10464.372137671764;10465;10591.417472039111;10633.255672103189;10649.680509584725 08:20:54 INFO - PROCESS | 15503 | __end_tp_report 08:20:54 INFO - PROCESS | 15503 | __start_cc_report 08:20:54 INFO - PROCESS | 15503 | _x_x_mozilla_cycle_collect,779 08:20:54 INFO - PROCESS | 15503 | __end_cc_report 08:20:54 INFO - PROCESS | 15503 | __startTimestamp1461079254601__endTimestamp 08:20:54 INFO - PROCESS | 15503 | 08:20:54 INFO - PROCESS | 15503 | ------- Summary: start ------- 08:20:54 INFO - PROCESS | 15503 | Number of tests: 6 08:20:54 INFO - PROCESS | 15503 | 08:20:54 INFO - PROCESS | 15503 | [#0] dojo.html Cycles:165 Average:5224.62 Median:5439.18 stddev:598.23 (11.0%) stddev-sans-first:573.76 08:20:54 INFO - PROCESS | 15503 | Values: 2988.0 3053.4 3081.3 3084.4 3110.8 5150.6 5226.8 5228.7 5249.9 5275.2 5241.8 5269.2 5352.4 5352.5 5355.9 4724.1 4775.2 4834.1 4869.3 4925.0 4838.4 4869.9 4899.3 4912.0 4920.4 4698.2 4718.7 4777.3 4815.7 4821.5 4799.9 4817.4 4828.1 4842.0 4856.1 4641.0 4780.0 4793.2 4799.7 4817.5 5159.6 5206.6 5228.6 5256.8 5273.8 5653.8 5660.7 5691.0 5691.1 5697.3 5524.3 5566.4 5698.1 5718.2 5723.0 5277.3 5294.3 5296.5 5322.8 5338.9 5798.2 5803.9 5805.8 5807.7 5809.2 5366.3 5453.1 5533.8 5536.1 5543.0 5592.0 5593.5 5598.7 5601.2 5629.1 5562.4 5567.6 5568.8 5572.2 5575.8 5497.4 5548.8 5589.5 5652.7 5690.5 4196.2 4197.1 4197.6 4197.6 4236.9 3804.9 3815.7 3825.1 3828.6 3845.6 5256.5 5267.4 5335.6 5357.2 5362.3 5616.7 5626.3 5628.2 5637.5 5651.1 5283.8 5293.3 5308.9 5313.5 5357.7 4593.8 4672.0 4672.4 4769.4 4771.3 5823.4 5825.9 5831.6 5851.8 5852.5 5645.4 5656.2 5658.7 5660.8 5664.4 5746.1 5756.3 5825.8 5863.8 5870.5 5566.5 5566.9 5573.6 5581.9 5582.3 5499.4 5643.6 5649.2 5649.6 5651.7 5426.9 5469.7 5470.4 5500.9 5519.6 5465.1 5465.6 5480.2 5488.7 5496.2 5328.3 5346.3 5373.0 5401.8 5446.1 5528.6 5539.6 5549.4 5561.2 5614.1 5398.9 5439.2 5439.4 5441.5 5482.0 08:20:54 INFO - PROCESS | 15503 | 08:20:54 INFO - PROCESS | 15503 | [#1] ext.html Cycles:180 Average:46914.25 Median:32765.09 stddev:76917.42 (234.8%) stddev-sans-first:77054.63 08:20:54 INFO - PROCESS | 15503 | Values: 611.3 641.8 651.0 656.1 667.2 29905.4 37352.0 37901.2 38070.2 38218.2 40027.6 40959.0 40998.8 41057.0 41088.0 7743.5 8392.2 8646.4 8648.3 9921.7 9893.4 10128.7 10133.1 10139.2 10140.6 10133.1 10210.9 10214.9 10217.7 10257.6 7949.4 10103.1 10284.8 10747.1 10751.0 10109.9 10208.1 10267.6 10273.2 10277.1 37835.2 38321.2 38350.0 38473.2 38528.8 3337.4 3412.4 3460.3 3466.9 3848.5 32486.7 32602.7 32673.0 32753.8 33918.8 4247.3 4284.7 4321.5 4369.0 4374.8 302956.0 303095.0 303413.0 306055.0 306656.0 58149.7 60239.0 60367.7 60378.0 60519.4 57030.4 57146.7 57272.4 57306.7 57353.0 15139.9 15444.6 15518.8 15523.0 15532.3 12139.5 12243.3 12249.4 12251.5 12252.9 17726.7 17858.6 17893.5 17939.9 17985.1 5244.6 6206.6 6247.7 6269.2 6289.9 1000.8 1049.5 1111.0 1125.9 1147.2 29491.9 31482.0 32756.3 32773.8 33436.3 1058.5 1104.8 1114.9 1141.6 1166.3 14656.6 15022.0 15028.3 15319.8 15335.2 316714.0 321298.0 321789.0 322044.7 323297.0 52419.7 52960.7 53398.5 58131.7 58255.0 1297.1 1315.9 1387.7 1420.4 1511.8 28361.4 30490.2 30638.2 31096.2 33212.3 46314.8 46710.5 46928.5 47130.8 47169.0 254350.0 254360.0 254971.0 255278.0 255491.0 23891.0 28356.4 28989.4 29310.1 29320.9 40349.8 40368.6 40613.4 41197.8 48271.8 36638.0 36817.0 37027.3 37395.0 40485.8 36249.3 37320.8 39623.4 39804.8 39985.4 41609.8 41681.0 41918.4 42076.8 43163.1 32482.4 34449.5 35047.7 35223.8 35563.6 27387.9 27419.0 27538.9 27634.1 27727.6 08:20:54 INFO - PROCESS | 15503 | 08:20:54 INFO - PROCESS | 15503 | [#2] jquery.html Cycles:180 Average:27319.54 Median:2949.88 stddev:75056.12 (2544.4%) stddev-sans-first:75239.40 08:20:54 INFO - PROCESS | 15503 | Values: 374.2 375.5 390.1 390.6 399.4 15048.5 17224.1 17249.7 18818.9 18821.2 17575.9 17578.6 18392.4 18398.5 19196.4 5485.8 5652.2 5669.7 5698.7 5708.8 5538.0 5613.8 5662.8 5663.9 5668.2 5475.3 5625.9 5632.6 5637.4 5642.8 5174.6 5526.9 5537.0 5549.5 5560.7 5258.5 5330.6 5368.5 5369.1 5369.1 22184.0 22317.0 22356.2 22520.3 22959.3 2159.0 2268.3 2401.7 2942.6 2957.1 9580.6 9699.0 10101.8 10252.8 14375.6 1738.5 1788.6 1799.6 1834.0 1858.9 77905.6 79723.0 80099.2 80143.6 80148.6 10248.9 10294.9 10738.6 10768.2 10901.7 14766.8 14772.3 14847.7 14856.9 14883.6 7581.8 7621.7 7722.8 7837.8 7956.1 7447.6 7492.3 7588.1 7603.4 7632.5 4450.9 4515.7 4548.8 4570.6 4615.4 1814.6 1830.6 1845.9 1847.9 1896.5 882.9 952.9 978.2 1014.7 1077.2 17740.3 18682.8 18785.6 18968.0 19086.9 1009.6 1018.5 1018.6 1051.8 1054.7 9977.5 10702.4 10732.3 10765.7 10805.5 436610.0 447249.0 455626.0 457680.0 473167.0 90692.5 92438.5 92544.1 92779.0 93429.0 995.6 1016.4 1030.6 1049.0 1051.4 16049.3 16421.5 16458.2 16701.5 16957.5 27128.3 35839.5 37032.6 38448.4 39940.0 48857.5 50438.5 52287.0 52384.7 52939.0 8301.4 8480.3 8519.2 8620.3 8831.9 9449.1 10138.1 10138.9 12374.9 13609.5 11267.6 11393.0 11398.4 11437.1 11600.4 10816.6 11160.7 11374.6 11659.5 12128.3 8528.4 11304.9 11323.4 11515.7 11685.8 8187.6 8187.8 8338.7 8782.6 8795.5 11159.2 11166.6 11225.2 11352.5 11445.1 08:20:54 INFO - PROCESS | 15503 | 08:20:54 INFO - PROCESS | 15503 | [#3] mootools.html Cycles:180 Average:5187.53 Median:4800.91 stddev:2916.47 (60.7%) stddev-sans-first:2910.60 08:20:54 INFO - PROCESS | 15503 | Values: 1378.6 1468.8 1515.4 1624.7 1785.4 7649.4 7989.1 8047.9 8061.7 8067.7 7581.8 7739.4 7743.0 7745.7 7758.2 1901.6 1963.1 1971.4 2235.3 2274.8 2204.8 2281.1 2287.6 2289.3 2289.4 2221.5 2245.4 2250.3 2251.8 2255.1 1952.8 2116.3 2120.2 2122.5 2153.6 2231.2 2246.6 2251.6 2253.2 2255.5 7903.5 7910.1 7946.0 7968.9 7988.0 4449.9 4621.6 4645.1 4649.2 4662.7 3025.0 3218.0 3303.4 3303.7 3328.4 992.5 999.2 1000.6 1009.4 1016.8 10518.3 10612.2 10636.1 10676.6 10814.7 3965.6 4019.7 4169.7 4178.2 4215.5 9307.8 9315.2 9315.8 9324.0 9327.5 4778.7 4788.5 4794.8 4807.0 4814.1 3954.0 4200.3 4282.3 4434.1 4478.3 3739.9 3751.7 3820.6 3833.9 3839.0 1074.3 1205.4 1232.6 1234.3 1242.9 827.6 833.6 843.4 862.3 868.1 5106.2 5132.2 5180.2 5290.8 5329.1 363.4 375.2 376.6 380.5 382.0 3514.8 3552.3 3558.6 3603.3 3646.2 9462.6 9800.7 9852.8 9903.3 9938.3 9805.4 9808.7 9809.0 9809.2 9809.4 7028.5 7545.4 7623.7 7634.2 7637.4 5269.2 5308.3 5314.5 5333.3 5383.6 8637.6 8732.4 8752.3 8825.7 8847.9 8749.5 8853.6 8891.9 8964.0 8976.1 6316.9 6441.7 6505.6 6994.9 7057.3 7393.7 7594.7 7613.2 7615.4 7617.1 6808.3 7139.8 7192.4 7211.4 7255.3 6809.0 6823.6 6899.5 6932.2 7035.2 6049.7 6238.7 6239.8 6421.5 6477.0 4383.9 4415.5 4471.8 4489.1 4514.7 4543.1 4602.7 4612.7 4635.8 4640.2 08:20:54 INFO - PROCESS | 15503 | 08:20:54 INFO - PROCESS | 15503 | [#4] prototype.html Cycles:180 Average:4925.47 Median:5693.09 stddev:1507.70 (26.5%) stddev-sans-first:1471.34 08:20:54 INFO - PROCESS | 15503 | Values: 295.6 296.4 303.0 304.8 306.5 5634.5 5647.5 5656.3 5691.0 5772.2 5594.0 5632.4 5633.7 5637.9 5651.3 4043.7 4105.6 4217.3 4217.8 4260.0 4243.2 4247.3 4251.8 4264.5 4265.0 4046.9 4231.8 4235.6 4240.4 4243.6 4140.6 4230.1 4258.8 4260.2 4266.0 3687.4 3695.3 3698.2 3700.5 3723.0 5326.9 5423.2 5454.3 5456.0 5475.2 4846.8 4887.1 4915.0 4930.2 4935.4 5851.5 5857.8 5858.2 5875.7 5884.6 4016.4 4076.6 4082.6 4100.4 4110.8 6109.1 6129.8 6151.3 6185.8 6191.9 4117.1 4139.5 4166.9 4177.7 4190.2 4209.9 4218.1 4220.5 4220.8 4231.2 4580.9 4840.8 4845.5 4854.9 4855.3 5950.1 5973.2 5980.7 5992.2 5994.1 1413.5 1414.5 1434.4 1436.7 1442.5 880.6 922.8 926.4 934.2 949.9 5680.4 5683.6 5688.9 5691.0 5704.4 6056.2 6065.4 6072.4 6079.7 6086.0 5547.9 5606.8 5723.9 5745.2 5766.3 3240.6 3254.4 3258.1 3265.5 3269.0 6197.2 6329.9 6332.8 6338.8 6367.5 6198.5 6213.3 6216.7 6226.4 6232.0 6112.8 6314.1 6332.4 6333.4 6342.3 5996.2 6047.2 6061.4 6074.8 6093.0 5962.6 5968.6 5976.1 5978.8 5988.7 6112.9 6303.1 6310.9 6324.0 6325.7 3992.0 4001.8 4008.1 4009.0 4022.4 5849.1 6028.4 6040.3 6054.6 6062.3 5886.2 5893.0 5901.4 5904.4 5938.1 5822.8 5862.4 5862.9 5902.4 5918.7 5545.3 5695.2 5765.7 5791.0 5896.1 5998.3 6017.4 6026.3 6039.3 6049.9 5722.4 5850.6 5860.9 5883.0 5905.5 08:20:54 INFO - PROCESS | 15503 | 08:20:54 INFO - PROCESS | 15503 | [#5] yui.html Cycles:180 Average:14967.65 Median:4322.47 stddev:18164.13 (420.2%) stddev-sans-first:18183.63 08:20:54 INFO - PROCESS | 15503 | Values: 732.7 762.9 797.3 797.3 802.9 13459.9 14102.4 14172.0 14238.1 14280.4 13378.3 13434.3 13442.4 13445.1 13446.1 671.3 770.9 796.1 798.4 804.8 800.5 809.0 809.2 809.9 811.7 855.9 855.9 857.1 857.4 857.8 704.9 817.5 839.6 839.9 853.3 613.8 613.9 614.7 614.7 615.2 12755.9 12803.7 12816.7 12832.4 12843.6 13762.4 13879.1 14191.1 14200.2 14277.9 10237.6 10379.4 10464.9 10558.5 10608.2 3738.2 3739.9 3820.6 3866.1 3972.7 57910.0 58659.4 59642.0 60550.7 60763.4 10187.1 10212.7 10367.6 10399.9 10699.8 19135.2 19298.5 19520.4 19602.9 19629.9 7352.5 7598.5 7659.4 7943.6 7952.9 4132.4 4190.2 4347.7 4416.8 4643.2 3065.4 3131.8 3137.9 3156.8 3157.8 561.0 575.4 590.7 596.8 598.4 671.2 694.2 697.4 698.2 708.0 8490.7 8659.7 8894.6 8904.8 8996.4 560.1 567.1 568.7 573.1 611.8 4172.1 4209.5 4238.5 4297.2 4367.6 66069.5 66299.7 67094.0 67144.7 67333.7 56204.0 57001.7 57189.1 57464.7 58185.0 50019.0 50699.7 50834.0 50857.5 51918.2 8162.1 8210.0 8309.4 8387.6 8390.1 34312.8 34872.1 35377.5 35496.5 35721.6 47006.0 47008.8 47283.5 47358.3 47851.0 10527.3 10578.5 10644.1 10772.6 10892.7 11437.8 11654.5 11920.3 12477.4 12715.7 11964.0 12109.4 12212.9 12716.4 12749.2 12000.9 12072.6 12271.9 12458.3 12784.9 11715.2 12130.8 12213.6 12627.4 12656.6 10031.8 10291.6 10295.8 10357.2 10725.7 10464.4 10465.0 10591.4 10633.3 10649.7 08:20:54 INFO - PROCESS | 15503 | -------- Summary: end -------- 08:20:54 INFO - PROCESS | 15503 | 08:20:55 INFO - TEST-INFO | 15503: exit 0 08:20:55 INFO - TEST-OK | dromaeo_css | took 1111233ms 08:20:55 INFO - TEST-START | kraken 08:20:55 INFO - operating with platform_type : linux_ 08:20:55 INFO - Initialising browser for kraken test... 08:20:55 INFO - TEST-INFO | started process 15688 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqzJMqI/profile http://localhost:54822/getInfo.html) 08:20:59 INFO - PROCESS | 15688 | __metrics Screen width/height:1600/1200 08:20:59 INFO - PROCESS | 15688 | colorDepth:24 08:20:59 INFO - PROCESS | 15688 | Browser inner width/height: 1024/697 08:20:59 INFO - PROCESS | 15688 | __metrics 08:21:00 ERROR - PROCESS | 15688 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 08:21:00 INFO - TEST-INFO | 15688: exit 0 08:21:00 INFO - Browser initialized. 08:21:00 INFO - Running cycle 1/1 for kraken test... 08:21:00 INFO - TEST-INFO | started process 15769 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqzJMqI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:21:12 INFO - PROCESS | 15769 | RSS: Main: 153083904 08:21:12 INFO - PROCESS | 15769 | 08:21:15 INFO - PROCESS | 15769 | Cycle 1(1): loaded http://localhost:54822/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54822/tests/kraken/driver.html?testName=audio-beat-detection) 08:21:15 INFO - PROCESS | 15769 | RSS: Main: 208887808 08:21:15 INFO - PROCESS | 15769 | 08:21:18 INFO - PROCESS | 15769 | Cycle 1(1): loaded http://localhost:54822/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54822/tests/kraken/driver.html?testName=audio-dft) 08:21:19 INFO - PROCESS | 15769 | RSS: Main: 194260992 08:21:19 INFO - PROCESS | 15769 | 08:21:22 INFO - PROCESS | 15769 | Cycle 1(1): loaded http://localhost:54822/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54822/tests/kraken/driver.html?testName=audio-fft) 08:21:22 INFO - PROCESS | 15769 | RSS: Main: 263815168 08:21:22 INFO - PROCESS | 15769 | 08:21:24 INFO - PROCESS | 15769 | Cycle 1(1): loaded http://localhost:54822/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54822/tests/kraken/driver.html?testName=audio-oscillator) 08:21:25 INFO - PROCESS | 15769 | RSS: Main: 173293568 08:21:25 INFO - PROCESS | 15769 | 08:21:27 INFO - PROCESS | 15769 | Cycle 1(1): loaded http://localhost:54822/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54822/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:21:28 INFO - PROCESS | 15769 | RSS: Main: 177287168 08:21:28 INFO - PROCESS | 15769 | 08:21:31 INFO - PROCESS | 15769 | Cycle 1(1): loaded http://localhost:54822/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54822/tests/kraken/driver.html?testName=imaging-darkroom) 08:21:31 INFO - PROCESS | 15769 | RSS: Main: 213626880 08:21:31 INFO - PROCESS | 15769 | 08:21:35 INFO - PROCESS | 15769 | Cycle 1(1): loaded http://localhost:54822/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54822/tests/kraken/driver.html?testName=imaging-desaturate) 08:21:35 INFO - PROCESS | 15769 | RSS: Main: 213848064 08:21:35 INFO - PROCESS | 15769 | 08:21:38 INFO - PROCESS | 15769 | Cycle 1(1): loaded http://localhost:54822/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54822/tests/kraken/driver.html?testName=json-parse-financial) 08:21:39 INFO - PROCESS | 15769 | RSS: Main: 214130688 08:21:39 INFO - PROCESS | 15769 | 08:21:40 INFO - PROCESS | 15769 | Cycle 1(1): loaded http://localhost:54822/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54822/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:21:41 INFO - PROCESS | 15769 | RSS: Main: 200888320 08:21:41 INFO - PROCESS | 15769 | 08:21:43 INFO - PROCESS | 15769 | Cycle 1(1): loaded http://localhost:54822/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54822/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:21:43 INFO - PROCESS | 15769 | RSS: Main: 202489856 08:21:43 INFO - PROCESS | 15769 | 08:21:45 INFO - PROCESS | 15769 | Cycle 1(1): loaded http://localhost:54822/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54822/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:21:46 INFO - PROCESS | 15769 | RSS: Main: 218120192 08:21:46 INFO - PROCESS | 15769 | 08:21:48 INFO - PROCESS | 15769 | Cycle 1(1): loaded http://localhost:54822/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54822/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:21:49 INFO - PROCESS | 15769 | RSS: Main: 223879168 08:21:49 INFO - PROCESS | 15769 | 08:21:52 INFO - PROCESS | 15769 | Cycle 1(1): loaded http://localhost:54822/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54822/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:21:52 INFO - PROCESS | 15769 | RSS: Main: 218906624 08:21:52 INFO - PROCESS | 15769 | 08:21:54 INFO - PROCESS | 15769 | Cycle 1(1): loaded http://localhost:54822/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54822/tests/kraken/driver.html?testName=ai-astar) 08:21:54 INFO - PROCESS | 15769 | RSS: Main: 282423296 08:21:54 INFO - PROCESS | 15769 | 08:21:54 INFO - PROCESS | 15769 | __start_tp_report 08:21:54 INFO - PROCESS | 15769 | _x_x_mozilla_page_load 08:21:54 INFO - PROCESS | 15769 | _x_x_mozilla_page_load_details 08:21:54 INFO - PROCESS | 15769 | |i|pagename|runs| 08:21:54 INFO - PROCESS | 15769 | |0;ai-astar;110;111;106;110;113;114;101;111;113;113 08:21:54 INFO - PROCESS | 15769 | |1;audio-beat-detection;151;134;156;180;128;161;162;127;191;136 08:21:54 INFO - PROCESS | 15769 | |2;audio-dft;161;161;161;160;161;161;160;162;163;163 08:21:54 INFO - PROCESS | 15769 | |3;audio-fft;75;78;104;111;73;76;76;121;108;77 08:21:54 INFO - PROCESS | 15769 | |4;audio-oscillator;93;94;153;92;92;93;146;92;93;147 08:21:54 INFO - PROCESS | 15769 | |5;imaging-gaussian-blur;117;117;117;117;117;116;116;118;118;117 08:21:54 INFO - PROCESS | 15769 | |6;imaging-darkroom;146;145;145;146;145;145;145;145;146;145 08:21:54 INFO - PROCESS | 15769 | |7;imaging-desaturate;94;95;94;94;94;95;95;94;94;96 08:21:54 INFO - PROCESS | 15769 | |8;json-parse-financial;58;56;61;60;58;57;60;81;56;55 08:21:54 INFO - PROCESS | 15769 | |9;json-stringify-tinderbox;61;61;62;62;61;60;61;61;61;62 08:21:54 INFO - PROCESS | 15769 | |10;stanford-crypto-aes;75;78;76;76;77;78;77;77;77;77 08:21:54 INFO - PROCESS | 15769 | |11;stanford-crypto-ccm;131;129;126;134;123;124;136;125;156;129 08:21:54 INFO - PROCESS | 15769 | |12;stanford-crypto-pbkdf2;166;164;164;163;164;165;170;165;167;166 08:21:54 INFO - PROCESS | 15769 | |13;stanford-crypto-sha256-iterative;70;69;69;69;68;67;71;68;68;67 08:21:54 INFO - PROCESS | 15769 | __end_tp_report 08:21:54 INFO - PROCESS | 15769 | __start_cc_report 08:21:54 INFO - PROCESS | 15769 | _x_x_mozilla_cycle_collect,1594 08:21:54 INFO - PROCESS | 15769 | __end_cc_report 08:21:54 INFO - PROCESS | 15769 | __startTimestamp1461079314894__endTimestamp 08:21:54 INFO - PROCESS | 15769 | 08:21:54 INFO - PROCESS | 15769 | ------- Summary: start ------- 08:21:54 INFO - PROCESS | 15769 | Number of tests: 14 08:21:54 INFO - PROCESS | 15769 | 08:21:54 INFO - PROCESS | 15769 | [#0] ai-astar Cycles:10 Average:110.20 Median:112.00 stddev:3.97 (3.5%) stddev-sans-first:4.21 08:21:54 INFO - PROCESS | 15769 | Values: 110.0 111.0 106.0 110.0 113.0 114.0 101.0 111.0 113.0 113.0 08:21:54 INFO - PROCESS | 15769 | 08:21:54 INFO - PROCESS | 15769 | [#1] audio-beat-detection Cycles:10 Average:152.60 Median:158.50 stddev:21.81 (13.8%) stddev-sans-first:23.12 08:21:54 INFO - PROCESS | 15769 | Values: 151.0 134.0 156.0 180.0 128.0 161.0 162.0 127.0 191.0 136.0 08:21:54 INFO - PROCESS | 15769 | 08:21:54 INFO - PROCESS | 15769 | [#2] audio-dft Cycles:10 Average:161.30 Median:161.00 stddev:1.06 (0.7%) stddev-sans-first:1.12 08:21:54 INFO - PROCESS | 15769 | Values: 161.0 161.0 161.0 160.0 161.0 161.0 160.0 162.0 163.0 163.0 08:21:54 INFO - PROCESS | 15769 | 08:21:54 INFO - PROCESS | 15769 | [#3] audio-fft Cycles:10 Average:89.90 Median:75.50 stddev:18.68 (24.7%) stddev-sans-first:19.02 08:21:54 INFO - PROCESS | 15769 | Values: 75.0 78.0 104.0 111.0 73.0 76.0 76.0 121.0 108.0 77.0 08:21:54 INFO - PROCESS | 15769 | 08:21:54 INFO - PROCESS | 15769 | [#4] audio-oscillator Cycles:10 Average:109.50 Median:92.50 stddev:27.09 (29.3%) stddev-sans-first:28.07 08:21:54 INFO - PROCESS | 15769 | Values: 93.0 94.0 153.0 92.0 92.0 93.0 146.0 92.0 93.0 147.0 08:21:54 INFO - PROCESS | 15769 | 08:21:54 INFO - PROCESS | 15769 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.67 (0.6%) stddev-sans-first:0.71 08:21:54 INFO - PROCESS | 15769 | Values: 117.0 117.0 117.0 117.0 117.0 116.0 116.0 118.0 118.0 117.0 08:21:54 INFO - PROCESS | 15769 | 08:21:54 INFO - PROCESS | 15769 | [#6] imaging-darkroom Cycles:10 Average:145.30 Median:145.00 stddev:0.48 (0.3%) stddev-sans-first:0.44 08:21:54 INFO - PROCESS | 15769 | Values: 146.0 145.0 145.0 146.0 145.0 145.0 145.0 145.0 146.0 145.0 08:21:54 INFO - PROCESS | 15769 | 08:21:54 INFO - PROCESS | 15769 | [#7] imaging-desaturate Cycles:10 Average:94.50 Median:94.50 stddev:0.71 (0.7%) stddev-sans-first:0.73 08:21:54 INFO - PROCESS | 15769 | Values: 94.0 95.0 94.0 94.0 94.0 95.0 95.0 94.0 94.0 96.0 08:21:54 INFO - PROCESS | 15769 | 08:21:54 INFO - PROCESS | 15769 | [#8] json-parse-financial Cycles:10 Average:60.20 Median:59.00 stddev:7.57 (12.8%) stddev-sans-first:7.99 08:21:54 INFO - PROCESS | 15769 | Values: 58.0 56.0 61.0 60.0 58.0 57.0 60.0 81.0 56.0 55.0 08:21:54 INFO - PROCESS | 15769 | 08:21:54 INFO - PROCESS | 15769 | [#9] json-stringify-tinderbox Cycles:10 Average:61.20 Median:61.00 stddev:0.63 (1.0%) stddev-sans-first:0.67 08:21:54 INFO - PROCESS | 15769 | Values: 61.0 61.0 62.0 62.0 61.0 60.0 61.0 61.0 61.0 62.0 08:21:54 INFO - PROCESS | 15769 | 08:21:54 INFO - PROCESS | 15769 | [#10] stanford-crypto-aes Cycles:10 Average:76.80 Median:77.00 stddev:0.92 (1.2%) stddev-sans-first:0.71 08:21:54 INFO - PROCESS | 15769 | Values: 75.0 78.0 76.0 76.0 77.0 78.0 77.0 77.0 77.0 77.0 08:21:54 INFO - PROCESS | 15769 | 08:21:54 INFO - PROCESS | 15769 | [#11] stanford-crypto-ccm Cycles:10 Average:131.30 Median:130.00 stddev:9.66 (7.4%) stddev-sans-first:10.25 08:21:54 INFO - PROCESS | 15769 | Values: 131.0 129.0 126.0 134.0 123.0 124.0 136.0 125.0 156.0 129.0 08:21:54 INFO - PROCESS | 15769 | 08:21:54 INFO - PROCESS | 15769 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.40 Median:165.50 stddev:2.01 (1.2%) stddev-sans-first:2.12 08:21:54 INFO - PROCESS | 15769 | Values: 166.0 164.0 164.0 163.0 164.0 165.0 170.0 165.0 167.0 166.0 08:21:54 INFO - PROCESS | 15769 | 08:21:54 INFO - PROCESS | 15769 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.60 Median:69.00 stddev:1.26 (1.8%) stddev-sans-first:1.24 08:21:54 INFO - PROCESS | 15769 | Values: 70.0 69.0 69.0 69.0 68.0 67.0 71.0 68.0 68.0 67.0 08:21:54 INFO - PROCESS | 15769 | -------- Summary: end -------- 08:21:54 INFO - PROCESS | 15769 | 08:21:55 INFO - TEST-INFO | 15769: exit 0 08:21:55 INFO - TEST-OK | kraken | took 60496ms 08:21:55 INFO - SUITE-END | took 1171s 08:21:56 INFO - Completed test suite (00:19:31) 08:21:56 INFO - javascript benchmark 08:21:56 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2988.0, 3053.4045861057075, 3081.3067059911523, 3084.3985422842543, 3110.7977981431213, 5150.613703972208, 5226.817061402851, 5228.686278823268, 5249.947500524993, 5275.182346736257, 5241.790328386869, 5269.156934890419, 5352.357717073947, 5352.464753524655, 5355.892882142355, 4724.102420540086, 4775.188218002931, 4834.081524510332, 4869.342638743778, 4925.039617274633, 4838.395200599925, 4869.878253043685, 4899.314096026559, 4911.950880491185, 4920.449903862436, 4698.154332220199, 4718.740469274188, 4777.283407488904, 4815.711057336536, 4821.493743156988, 4799.856004319841, 4817.3737414136285, 4828.0585285869265, 4842.031593681243, 4856.05306965142, 4640.976795116003, 4780.0, 4793.18515852306, 4799.664023518355, 4817.470078291385, 5159.587233021387, 5206.635535512516, 5228.607854410934, 5256.81601143962, 5273.789048438058, 5653.830385088413, 5660.660360378391, 5691.032524470808, 5691.146328050825, 5697.287839020122, 5524.33707955048, 5566.415526369713, 5698.116791897262, 5718.228039214736, 5723.0, 5277.261183434322, 5294.258803767514, 5296.549793267538, 5322.840314790524, 5338.893222135535, 5798.246227990418, 5803.9419605803405, 5805.82582522525, 5807.738651760681, 5809.215755872903, 5366.329208848894, 5453.127499600045, 5533.750981205855, 5536.141898005815, 5542.972285138549, 5592.049351610236, 5593.496585307342, 5598.664080155204, 5601.215829783833, 5629.099344104923, 5562.443755624486, 5567.638103523258, 5568.805091821767, 5572.219889215513, 5575.832725018256, 5497.367802702661, 5548.750306236229, 5589.450698806206, 5652.660840349592, 5690.487856092972, 4196.223698615766, 4197.055662475918, 4197.559256278108, 4197.601227883346, 4236.894077648083, 3804.9239015220096, 3815.6756675682323, 3825.0819803247578, 3828.5979972103087, 3845.6346647068485, 5256.474352564713, 5267.394249661262, 5335.573154147659, 5357.19642053695, 5362.329708786402, 5616.66300022, 5626.324841019022, 5628.212050312877, 5637.46444087811, 5651.095824668033, 5283.788648454019, 5293.258943747878, 5308.893822123536, 5313.521783039545, 5357.732113394315, 4593.839215627504, 4672.0, 4672.392588963413, 4769.42766867978, 4771.308160316735, 5823.388544202882, 5825.854353641193, 5831.620944638585, 5851.795187168514, 5852.502537284378, 5645.4072322405555, 5656.23640808502, 5658.688772117573, 5660.830175094754, 5664.376918538875, 5746.080627099811, 5756.30924289088, 5825.76696932118, 5863.765449381977, 5870.53035757147, 5566.526845218202, 5566.916496252478, 5573.6098473106495, 5581.860453488533, 5582.27430434041, 5499.395066542597, 5643.633163844337, 5649.209110724584, 5649.604527683023, 5651.660900345993, 5426.864328391822, 5469.699166545878, 5470.398256191736, 5500.9174862377895, 5519.586031047607, 5465.070937940639, 5465.617406781487, 5480.150576660624, 5488.69812160319, 5496.203050557727, 5328.307320048369, 5346.331708536433, 5372.973135134299, 5401.810936617199, 5446.128619421032, 5528.55771538284, 5539.584531160099, 5549.389567147691, 5561.221429000024, 5614.101743720985, 5398.946010539844, 5439.184122381675, 5439.401665816836, 5441.5374693151525, 5482.013237617267], "value": 5183.939789807575, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [611.3428064830306, 641.7978336823898, 650.9934900650993, 656.1109696361433, 667.1727058447525, 29905.40189196215, 37352.0, 37901.24197516055, 38070.23859522808, 38218.23563528728, 40027.59972400275, 40959.0, 40998.795006025, 41057.0, 41088.0, 7743.496672716284, 8392.244697977181, 8646.394752367336, 8648.308135349189, 9921.702348929544, 9893.356931799446, 10128.746781330488, 10133.08802207801, 10139.188864890792, 10140.594376224943, 10133.138683211935, 10210.89789102107, 10214.89785102147, 10217.744556386113, 10257.589696412135, 7949.40379471539, 10103.090721835033, 10284.794304113952, 10747.08649764771, 10751.0, 10109.949450252701, 10208.081272685495, 10267.589296428134, 10273.229507786946, 10277.126444252248, 37835.24329513422, 38321.23357532834, 38350.0, 38473.230535389135, 38528.80735596332, 3337.4326364517847, 3412.3516531859113, 3460.2906404187083, 3466.8959931202103, 3848.4804551385487, 32486.675133248602, 32602.673973260436, 32673.0, 32753.83623081893, 33918.83040584781, 4247.277962746341, 4284.721493102938, 4321.4935337504485, 4368.956310436887, 4374.825006999717, 302956.0, 303095.0, 303413.0, 306055.0, 306656.0, 58149.70925145432, 60239.0, 60367.69816150891, 60378.0, 60519.39480605138, 57030.429695702514, 57146.71426642923, 57272.42727572671, 57306.713466432404, 57353.0, 15139.924300378427, 15444.613884652974, 15518.844811551966, 15523.0, 15532.301046452936, 12139.453724582416, 12243.326617035971, 12249.387530623433, 12251.509939602316, 12252.877471225353, 17726.734098988527, 17858.642827143383, 17893.463196104138, 17939.910300448675, 17985.1007449627, 5244.580433565306, 6206.565540412128, 6247.687615619201, 6269.247690277196, 6289.886506179379, 1000.8448690452991, 1049.501486793782, 1111.0112000319723, 1125.921185517006, 1147.225622704671, 29491.85254073716, 31482.0, 32756.344873102404, 32773.83613081967, 33436.331273374395, 1058.4866339825178, 1104.7569534702352, 1114.9386783726811, 1141.6346769033996, 1166.2594252649628, 14656.560303190921, 15022.0, 15028.323725432381, 15319.770203446957, 15335.156566388732, 316714.0, 321298.0, 321789.0, 322044.6773193616, 323297.0, 52419.73790131025, 52960.735196323774, 53398.46601534013, 58131.709341453025, 58255.0, 1297.1438850358718, 1315.8684131586956, 1387.7363300972784, 1420.424727985147, 1511.8185817701726, 28361.43277134487, 30490.237744056576, 30638.21310291573, 31096.22259443532, 33212.33575328528, 46314.76842615765, 46710.53289467062, 46928.53071469242, 47130.764346178046, 47169.0, 254350.0, 254360.0, 254971.0, 255278.0, 255491.0, 23891.0, 28356.43287134287, 28989.420211596072, 29310.12069637914, 29320.853395732884, 40349.79825100856, 40368.596314036484, 40613.39079913744, 41197.79401102975, 48271.75864120657, 36638.0, 36817.0, 37027.25945481129, 37395.0, 40485.79757101196, 36249.27501450009, 37320.81339593285, 39623.40564891587, 39804.800975994935, 39985.40094893822, 41609.79195104005, 41681.0, 41918.371224431045, 42076.78961605173, 43163.115319621385, 32482.35035299328, 34449.48325775166, 35047.72930274783, 35223.82388088043, 35563.644363556035, 27387.86306068457, 27419.0, 27538.862305689145, 27634.091994270286, 27727.584086239127], "value": 19090.02769541967, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [374.1936127644925, 375.4968342421155, 390.1047096912585, 390.5703725901509, 399.4367941202905, 15048.473303434383, 17224.13879306036, 17249.65500689987, 18818.90590547049, 18821.153048112832, 17575.91212043938, 17578.64842703145, 18392.44822655319, 18398.540036499093, 19196.42410727677, 5485.780568777254, 5652.236948012007, 5669.659820410789, 5698.6865722385255, 5708.771649134051, 5537.972310138463, 5613.775448982035, 5662.801801936933, 5663.8584035399235, 5668.206451096829, 5475.288212532365, 5625.8593535161535, 5632.577556683244, 5637.436256374371, 5642.774289028454, 5174.637775355726, 5526.861828454281, 5537.0, 5549.528290095326, 5560.749766260528, 5258.526732594085, 5330.631920913825, 5368.543673787733, 5369.0604144274985, 5369.140937449989, 22184.0, 22317.0, 22356.21753238645, 22520.324390268153, 22959.311220663407, 2158.9568208635737, 2268.2514770125817, 2401.6997875265592, 2942.6174597302215, 2957.142428695676, 9580.61677532898, 9699.0, 10101.797964040677, 10252.846207306897, 14375.640608984755, 1738.4610770661136, 1788.5975655477544, 1799.6040871008356, 1834.0, 1858.8977606231651, 77905.61047194785, 79723.0, 80099.19900800976, 80143.5992820038, 80148.59925700392, 10248.897511024943, 10294.948525257476, 10738.624148154777, 10768.192385570957, 10901.672949811518, 14766.778498322534, 14772.335244914004, 14847.70304593902, 14856.851431485762, 14883.586059324347, 7581.810454738676, 7621.6570254338685, 7722.806929826799, 7837.843243135106, 7956.124826269106, 7447.590382529013, 7492.325690687864, 7588.127365352944, 7603.4297427693145, 7632.465727399029, 4450.910981780346, 4515.68390212682, 4548.818047278138, 4570.588647021717, 4615.376924115269, 1814.646144001907, 1830.6155707301616, 1845.8892466452055, 1847.8706490545533, 1896.506908203877, 882.8808110904946, 952.9428234305964, 978.1929907826072, 1014.6955913226003, 1077.1544337694872, 17740.29038838432, 18682.81317186838, 18785.624287514445, 18968.0, 19086.904565477085, 1009.6112996496402, 1018.5212949913529, 1018.5976539266948, 1051.779126383468, 1054.7257712994676, 9977.501124943723, 10702.357858528514, 10732.302400343953, 10765.730856728644, 10805.459727013775, 436610.0, 447249.0, 455626.0, 457680.0, 473167.0, 90692.54653726821, 92438.53780731054, 92544.07455925489, 92779.0, 93429.0, 995.6266400099962, 1016.3850870223556, 1030.6289735695143, 1048.9527971241312, 1051.395447617623, 16049.277782500048, 16421.507354779376, 16458.177091145633, 16701.49895503137, 16957.49127526176, 27128.32179195536, 35839.46240806442, 37032.62967370292, 38448.423273650355, 39940.0, 48857.5114248853, 50438.49561504338, 52287.0, 52384.738076309375, 52939.0, 8301.377396695152, 8480.321574274167, 8519.23326900582, 8620.310375169845, 8831.91168088311, 9449.102335278138, 10138.138258248131, 10138.949305253427, 12374.938125309316, 13609.52366667162, 11267.605633803105, 11393.0, 11398.430078496207, 11437.085033197158, 11600.361980091177, 10816.621418250323, 11160.720981975515, 11374.601888933848, 11659.475323610288, 12128.332941687939, 8528.445651032664, 11304.943475282571, 11323.377214253294, 11515.654530364103, 11685.76628467409, 8187.590620469072, 8187.83624327522, 8338.708145214889, 8782.648694052166, 8795.47227166372, 11159.163062770162, 11166.553337866395, 11225.158113141384, 11352.54589816398, 11445.141614379121], "value": 8894.553438655166, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1378.6002059402774, 1468.8237411510618, 1515.4392874636387, 1624.683186778578, 1785.4286628278949, 7649.388048956084, 7989.081255655601, 8047.879281810778, 8061.677532898684, 8067.677292908292, 7581.772546823604, 7739.419543534229, 7743.0, 7745.728899488519, 7758.224177582239, 1901.648195083907, 1963.0577322885024, 1971.3593082248256, 2235.3182279404814, 2274.8293877959136, 2204.8236141108755, 2281.0761641535205, 2287.576798292313, 2289.301762962296, 2289.3933107726466, 2221.544583360407, 2245.4049676835652, 2250.313654335427, 2251.752307246202, 2255.109231853417, 1952.80471952805, 2116.3016204652504, 2120.162535798359, 2122.4693826543366, 2153.6123497770395, 2231.1856172497082, 2246.640537514006, 2251.6284813006, 2253.211376018397, 2255.537614788964, 7903.525788452654, 7910.090339610961, 7946.0, 7968.880466793003, 7988.041435027776, 4449.866504004885, 4621.630269578459, 4645.094206629708, 4649.163150632885, 4662.7202367858035, 3024.9848750756105, 3218.0, 3303.3888730584677, 3303.653116422765, 3328.384248913959, 992.4789485520088, 999.160705007797, 1000.5997600959602, 1009.369144284822, 1016.7915577306634, 10518.316309439939, 10612.151027917747, 10636.095931845803, 10676.572937082507, 10814.675559733221, 3965.5836137205756, 4019.698522610816, 4169.728967617095, 4178.206140833232, 4215.515215750167, 9307.76730581741, 9315.20820730232, 9315.813683726288, 9324.0, 9327.486988215713, 4778.737169455644, 4788.497207793202, 4794.7842347094465, 4807.038592281558, 4814.061258054716, 3954.0, 4200.264953633102, 4282.314829627245, 4434.068845542408, 4478.261086920622, 3739.9252014960093, 3751.718621103428, 3820.56063552695, 3833.923321533554, 3839.0, 1074.3285446595878, 1205.4153735438306, 1232.6055662188014, 1234.3149551998727, 1242.8943539799038, 827.6151589510906, 833.6040380819062, 843.3590471241778, 862.344618090256, 868.1231955724763, 5106.234064890296, 5132.204508301219, 5180.222966555047, 5290.761915713802, 5329.067413202752, 363.4058314655557, 375.21954334983167, 376.6045652065321, 380.4559479943707, 381.96944244460377, 3514.7715398499017, 3552.307300076512, 3558.5907620623443, 3603.3333833240936, 3646.1796095878744, 9462.57418416173, 9800.65697700577, 9852.80294394108, 9903.25725570585, 9938.304318697621, 9805.411675299505, 9808.705738827846, 9808.950955245178, 9809.166220871162, 9809.362391444532, 7028.508004439743, 7545.396368290523, 7623.695052197961, 7634.236576342321, 7637.389008879276, 5269.1569348903995, 5308.309919710413, 5314.4951229633125, 5333.253344531846, 5383.569314454912, 8637.611307491303, 8732.432391894507, 8752.29981601483, 8825.69110081144, 8847.911520884967, 8749.5187764671, 8853.645854165761, 8891.866622000805, 8963.955180224057, 8976.102389761232, 6316.905246421399, 6441.7116576685785, 6505.642189679613, 6994.930050699428, 7057.294270572902, 7393.667284972082, 7594.734184303523, 7613.162552119373, 7615.352695020985, 7617.124030736536, 6808.251092379735, 7139.821504462222, 7192.352688258082, 7211.350978411968, 7255.310745479171, 6809.0, 6823.55646882951, 6899.517033807585, 6932.23745388017, 7035.190953040261, 6049.727762250621, 6238.6880655966115, 6239.78160764371, 6421.454176395058, 6477.0, 4383.912321753483, 4415.536368681371, 4471.776411179493, 4489.1470620583295, 4514.68397212192, 4543.068670922519, 4602.677812553089, 4612.723236605814, 4635.768211589339, 4640.164770341371], "value": 4106.119345317404, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [295.58470349159427, 296.3864799864281, 303.0333236974053, 304.84452929006216, 306.4942844306892, 5634.4928956393915, 5647.548196144314, 5656.2929633795775, 5691.0, 5772.163036359725, 5594.007206144714, 5632.436756324366, 5633.746481408336, 5637.8590535236635, 5651.32184137903, 4043.7169398142214, 4105.630493255607, 4217.34631132175, 4217.7891105444605, 4260.0, 4243.151369726052, 4247.299195632717, 4251.766152861592, 4264.547884966141, 4264.978675106636, 4046.9190616187657, 4231.830726770941, 4235.555266696999, 4240.406343111967, 4243.618074373306, 4140.60664236897, 4230.132822771325, 4258.787060646986, 4260.21186080573, 4265.957340426618, 3687.3915803892323, 3695.2609478104487, 3698.2418604186346, 3700.5189325387796, 3722.9947914063323, 5326.92009619856, 5423.152844756534, 5454.290942177491, 5456.03582710224, 5475.178723191513, 4846.7576621169155, 4887.095887260868, 4914.950850491485, 4930.235813448921, 4935.407751069894, 5851.531877449794, 5857.7949771757785, 5858.150568167592, 5875.735591898375, 5884.617499862496, 4016.377461493473, 4076.5923407658997, 4082.591740825894, 4100.405441211037, 4110.815013324408, 6109.083637454418, 6129.816105516842, 6151.292601350857, 6185.752569897199, 6191.873104082455, 4117.135401565645, 4139.503259608866, 4166.8749937501925, 4177.707560470799, 4190.203861266411, 4209.852655157055, 4218.135282267128, 4220.5146408163455, 4220.831166753295, 4231.174920890397, 4580.862574122782, 4840.75796210188, 4845.53967373099, 4854.902901941941, 4855.295982082578, 5950.107483877453, 5973.223480947449, 5980.671063091485, 5992.221011268594, 5994.100884867305, 1413.5264686330195, 1414.5119933622884, 1434.390384086759, 1436.6911114110517, 1442.451868290043, 880.6037283222576, 922.7923717163719, 926.3978414030934, 934.1685899549407, 949.8622699708503, 5680.403557626472, 5683.630564013326, 5688.914666280009, 5690.971545142331, 5704.429557044263, 6056.242969628796, 6065.361567718057, 6072.362401947732, 6079.6960151992225, 6085.9695701521205, 5547.944520554824, 5606.775728970795, 5723.914141287884, 5745.1669507921115, 5766.336871259775, 3240.643529211832, 3254.3816674831705, 3258.1365938026443, 3265.4775235962134, 3269.019294211727, 6197.163382943335, 6329.936700633027, 6332.8416789579705, 6338.809835704937, 6367.522435817332, 6198.473129783929, 6213.316535181127, 6216.720247588869, 6226.377362263828, 6232.0, 6112.816615501453, 6314.0844577536, 6332.39842214998, 6333.398327158912, 6342.302346741854, 5996.160537524837, 6047.244094488189, 6061.36355682647, 6074.757009719562, 6092.969535152296, 5962.64475532171, 5968.641881487125, 5976.133460648269, 5978.760849565969, 5988.6706231157705, 6112.908306375497, 6303.0775613438345, 6310.905336419865, 6323.9683801580695, 6325.746970121144, 3992.0, 4001.7999100045463, 4008.0781420272915, 4008.9599104008585, 4022.4167495712372, 5849.122631605123, 6028.3971602839365, 6040.275166979991, 6054.638690910637, 6062.333143354315, 5886.175935368966, 5892.970535147297, 5901.439363260483, 5904.439078287556, 5938.138969849434, 5822.796202132905, 5862.355140934408, 5862.882742345044, 5902.350741418355, 5918.73365698536, 5545.334559852843, 5695.174199741097, 5765.682887441231, 5790.973159394347, 5896.14505896634, 5998.25021872266, 6017.428344307284, 6026.306974697791, 6039.275286965592, 6049.939500604937, 5722.4277572242445, 5850.561207909339, 5860.853478663067, 5883.0, 5905.498032667271], "value": 4423.484721509109, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [732.7105793211681, 762.9008228930238, 797.3382092862925, 797.3421926910298, 802.8635132027555, 13459.932700336496, 14102.435902563899, 14172.0, 14238.145711257332, 14280.428782848687, 13378.331083445813, 13434.261115638661, 13442.39509222085, 13445.126066805651, 13446.058775885693, 671.2817285504512, 770.9498882572643, 796.0884786918974, 798.3692882622736, 804.8189157439588, 800.5156880087551, 809.0372456776447, 809.1503920883079, 809.8582748019103, 811.7199566149669, 855.9101294364095, 855.9186877246651, 857.1342943626951, 857.3826844671827, 857.8241460500583, 704.9154101507826, 817.4604760857835, 839.6137776622761, 839.8656215005631, 853.3343991686495, 613.7882430561449, 613.8741557980603, 614.7110857896781, 614.7387360371869, 615.1848800339568, 12755.872441275562, 12803.743925121445, 12816.731733408014, 12832.358382080858, 12843.614691559269, 13762.449502019907, 13879.097858639156, 14191.077579957373, 14200.218987955659, 14277.857221427861, 10237.641682541076, 10379.42913139777, 10464.947675261652, 10558.472076396227, 10608.20438467118, 3738.1776009277914, 3739.925201495982, 3820.59883712209, 3866.0914685048992, 3972.741771784825, 57910.0, 58659.413405865824, 59642.0, 60550.697246513926, 60763.392366076216, 10187.08316251526, 10212.693619191436, 10367.585296588202, 10399.94800025995, 10699.786004279871, 19135.23459061622, 19298.517537061405, 19520.414387568395, 19602.90198548998, 19629.901850490656, 7352.485326027234, 7598.468107232441, 7659.425543084291, 7943.602819858984, 7952.920470795334, 4132.359484279941, 4190.245755763931, 4347.739135651871, 4416.80124394403, 4643.187442197602, 3065.417570661612, 3131.765117616188, 3137.8587963541695, 3156.7632427568024, 3157.8105313681253, 560.9971950140223, 575.4098928905702, 590.7282649981057, 596.7642781101528, 598.3537779198455, 671.1744554198364, 694.2206133935011, 697.4211404534225, 698.155232169081, 707.9539829911039, 8490.702825401082, 8659.740207793777, 8894.555272236363, 8904.777380565538, 8996.370254082281, 560.0982418306523, 567.0898208375498, 568.7014317483354, 573.1488739222251, 611.7705860302386, 4172.123853990696, 4209.494860616745, 4238.470191226097, 4297.205017071852, 4367.6287515561535, 66069.48371818842, 66299.66850165719, 67094.0, 67144.6642766783, 67333.66333168303, 56204.0, 57001.71499142478, 57189.14216286759, 57464.71267643635, 58185.0, 50018.99999999927, 50699.746501267255, 50834.0, 50857.49142508602, 51918.22122668163, 8162.061362943337, 8210.01479822425, 8309.418340716093, 8387.622556985072, 8390.065494588478, 34312.79905203406, 34872.12819679427, 35377.46933795944, 35496.46755298724, 35721.64278357287, 47006.0, 47008.764956175, 47283.527164727915, 47358.28962565495, 47851.0, 10527.315724477885, 10578.471076446302, 10644.148468122687, 10772.569097236335, 10892.727681808019, 11437.828432573351, 11654.53381864716, 11920.284782913053, 12477.376131193585, 12715.745685086431, 11964.0, 12109.394530273275, 12212.938935305267, 12716.427760750974, 12749.17130386522, 12000.939995299968, 12072.637820865388, 12271.938640306742, 12458.314792686127, 12784.872151278369, 11715.17993740464, 12130.818037729265, 12213.633590992284, 12627.368631568568, 12656.557020504239, 10031.849522257025, 10291.588336466457, 10295.794084118126, 10357.223208259562, 10725.731856703645, 10464.372137671764, 10465.0, 10591.417472039111, 10633.255672103189, 10649.680509584725], "value": 6531.315310051958, "unit": "score"}], "name": "dromaeo_css", "value": 6862.340205168965, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 111.0, 106.0, 110.0, 113.0, 114.0, 101.0, 111.0, 113.0, 113.0], "value": 110.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 134.0, 156.0, 180.0, 128.0, 161.0, 162.0, 127.0, 191.0, 136.0], "value": 152.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 161.0, 160.0, 161.0, 161.0, 160.0, 162.0, 163.0, 163.0], "value": 161.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 78.0, 104.0, 111.0, 73.0, 76.0, 76.0, 121.0, 108.0, 77.0], "value": 89.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 94.0, 153.0, 92.0, 92.0, 93.0, 146.0, 92.0, 93.0, 147.0], "value": 109.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 116.0, 118.0, 118.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 145.0, 146.0, 145.0, 145.0, 145.0, 145.0, 146.0, 145.0], "value": 145.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 94.0, 94.0, 94.0, 95.0, 95.0, 94.0, 94.0, 96.0], "value": 94.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 56.0, 61.0, 60.0, 58.0, 57.0, 60.0, 81.0, 56.0, 55.0], "value": 60.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 62.0, 62.0, 61.0, 60.0, 61.0, 61.0, 61.0, 62.0], "value": 61.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 78.0, 76.0, 76.0, 77.0, 78.0, 77.0, 77.0, 77.0, 77.0], "value": 76.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [131.0, 129.0, 126.0, 134.0, 123.0, 124.0, 136.0, 125.0, 156.0, 129.0], "value": 131.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 164.0, 164.0, 163.0, 164.0, 165.0, 170.0, 165.0, 167.0, 166.0], "value": 165.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 69.0, 69.0, 69.0, 68.0, 67.0, 71.0, 68.0, 68.0, 67.0], "value": 68.6, "unit": "score"}], "name": "kraken", "value": 1543.8, "alertThreshold": 2.0}]} 08:21:56 INFO - Return code: 0 08:21:56 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 08:21:56 ERROR - # TBPL SUCCESS # 08:21:56 INFO - Running post-action listener: _resource_record_post_action 08:21:56 INFO - Running post-run listener: _resource_record_post_run 08:21:57 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 12288; Write bytes: 543621120; Read time: 220; Write time: 525736 08:21:57 INFO - install - Wall time: 17s; CPU: 15.0%; Read bytes: 0; Write bytes: 251535360; Read time: 0; Write time: 328404 08:21:57 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 12288; Write bytes: 292085760; Read time: 220; Write time: 197332 08:21:57 INFO - Running post-run listener: _upload_blobber_files 08:21:57 INFO - Blob upload gear active. 08:21:57 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:21:57 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 08:21:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:21:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:21:57 INFO - (blobuploader) - INFO - Open directory for files ... 08:21:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:21:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:21:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:21:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:21:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:21:58 INFO - (blobuploader) - INFO - Done attempting. 08:21:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:21:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:21:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:21:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:21:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:21:59 INFO - (blobuploader) - INFO - Done attempting. 08:21:59 INFO - (blobuploader) - INFO - Iteration through files over. 08:21:59 INFO - Return code: 0 08:21:59 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:21:59 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:21:59 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8419871f134f46fadd102851d1d1af76c795390c4d08133aaa80474ec7c83706ff7aec339c6ab48cb59e089f6790d89f101430506c96feeb474f7cfc6626de78", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d2c2d9496648ff9f2c68a10bd154006b95d6f0f3f901e909f50e0c0e86a02255de9e648d1a3ac251a9c86621cbaa21ec874c5517e92e06c2918437738b4a4fe6"} 08:21:59 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:21:59 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:21:59 INFO - Contents: 08:21:59 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8419871f134f46fadd102851d1d1af76c795390c4d08133aaa80474ec7c83706ff7aec339c6ab48cb59e089f6790d89f101430506c96feeb474f7cfc6626de78", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d2c2d9496648ff9f2c68a10bd154006b95d6f0f3f901e909f50e0c0e86a02255de9e648d1a3ac251a9c86621cbaa21ec874c5517e92e06c2918437738b4a4fe6"} 08:21:59 INFO - Running post-run listener: copy_logs_to_upload_dir 08:21:59 INFO - Copying logs to upload dir... 08:21:59 INFO - mkdir: /builds/slave/test/build/upload/logs 08:21:59 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1230.310509 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 30 secs) (at 2016-04-19 08:21:59.143199) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-19 08:21:59.146619) ========= 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=03627c79f6bb3d1578c4a402000001ba-1461075624.734061-793787237 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/sha512/8419871f134f46fadd102851d1d1af76c795390c4d08133aaa80474ec7c83706ff7aec339c6ab48cb59e089f6790d89f101430506c96feeb474f7cfc6626de78", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d2c2d9496648ff9f2c68a10bd154006b95d6f0f3f901e909f50e0c0e86a02255de9e648d1a3ac251a9c86621cbaa21ec874c5517e92e06c2918437738b4a4fe6"} build_url:https://queue.taskcluster.net/v1/task/IJo0AJqER7SqedWTOTAQCQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011378 build_url: 'https://queue.taskcluster.net/v1/task/IJo0AJqER7SqedWTOTAQCQ/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/sha512/8419871f134f46fadd102851d1d1af76c795390c4d08133aaa80474ec7c83706ff7aec339c6ab48cb59e089f6790d89f101430506c96feeb474f7cfc6626de78", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d2c2d9496648ff9f2c68a10bd154006b95d6f0f3f901e909f50e0c0e86a02255de9e648d1a3ac251a9c86621cbaa21ec874c5517e92e06c2918437738b4a4fe6"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-19 08:21:59.171689) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-19 08:21:59.172018) ========= 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=03627c79f6bb3d1578c4a402000001ba-1461075624.734061-793787237 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004377 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-19 08:21:59.256224) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-19 08:21:59.256578) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-19 08:21:59.256893) ========= ========= Total master_lag: 0.70 =========