builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-038 starttime: 1463509571.73 results: success (0) buildid: 20160517085230 builduid: 96e9bcea91ac4aa78169716722e30437 revision: fb923f1876f55311ba595c7af364f4396e8595f6 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-17 11:26:11.728817) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-17 11:26:11.729350) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-17 11:26:11.729698) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-17 11:26:11.747640) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-17 11:26:11.747930) ========= 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=8783db0840cc980e80bb0bd400000236-1463509571.83882-1470594797 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-17 11:26:11-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 224M=0s 2016-05-17 11:26:11 (224 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.118741 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-17 11:26:11.880269) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-17 11:26:11.880599) ========= 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=8783db0840cc980e80bb0bd400000236-1463509571.83882-1470594797 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017973 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-17 11:26:11.930862) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-17 11:26:11.931218) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev fb923f1876f55311ba595c7af364f4396e8595f6 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev fb923f1876f55311ba595c7af364f4396e8595f6 --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=8783db0840cc980e80bb0bd400000236-1463509571.83882-1470594797 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-17 11:26:12,027 truncating revision to first 12 chars 2016-05-17 11:26:12,027 Setting DEBUG logging. 2016-05-17 11:26:12,027 attempt 1/10 2016-05-17 11:26:12,027 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/fb923f1876f5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-17 11:26:12,295 unpacking tar archive at: mozilla-beta-fb923f1876f5/testing/mozharness/ program finished with exit code 0 elapsedTime=0.579459 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-17 11:26:12.524506) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-17 11:26:12.524889) ========= script_repo_revision: fb923f1876f55311ba595c7af364f4396e8595f6 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-17 11:26:12.525325) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-17 11:26:12.525622) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-17 11:26:12.535385) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 24 secs) (at 2016-05-17 11:26:12.535677) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 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', 'Mozilla-Beta', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] 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=8783db0840cc980e80bb0bd400000236-1463509571.83882-1470594797 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:26:12 INFO - MultiFileLogger online at 20160517 11:26:12 in /builds/slave/test 11:26:12 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 11:26:12 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:26:12 INFO - {'append_to_log': False, 11:26:12 INFO - 'base_work_dir': '/builds/slave/test', 11:26:12 INFO - 'blob_upload_branch': 'Mozilla-Beta', 11:26:12 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:26:12 INFO - 'branch': 'Mozilla-Beta', 11:26:12 INFO - 'buildbot_json_path': 'buildprops.json', 11:26:12 INFO - 'config_files': ('talos/linux_config.py',), 11:26:12 INFO - 'default_actions': ('clobber', 11:26:12 INFO - 'read-buildbot-config', 11:26:12 INFO - 'download-and-extract', 11:26:12 INFO - 'populate-webroot', 11:26:12 INFO - 'create-virtualenv', 11:26:12 INFO - 'install', 11:26:12 INFO - 'run-tests'), 11:26:12 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:26:12 INFO - 'download_minidump_stackwalk': True, 11:26:12 INFO - 'download_symbols': 'ondemand', 11:26:12 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:26:12 INFO - 'tooltool.py': '/tools/tooltool.py', 11:26:12 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:26:12 INFO - '/tools/misc-python/virtualenv.py')}, 11:26:12 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:26:12 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:26:12 INFO - 'installer_path': 'installer.exe', 11:26:12 INFO - 'log_level': 'info', 11:26:12 INFO - 'log_name': 'talos', 11:26:12 INFO - 'log_to_console': True, 11:26:12 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:26:12 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:26:12 INFO - 'opt_config_files': (), 11:26:12 INFO - 'pip_index': False, 11:26:12 INFO - 'sps_profile': False, 11:26:12 INFO - 'sps_profile_interval': 0, 11:26:12 INFO - 'suite': 'dromaeojs', 11:26:12 INFO - 'system_bits': '32', 11:26:12 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:26:12 INFO - 'title': 'talos-linux64-ix-038', 11:26:12 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:26:12 INFO - 'use_talos_json': True, 11:26:12 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:26:12 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:26:12 INFO - 'work_dir': 'build'} 11:26:12 INFO - ##### 11:26:12 INFO - ##### Running clobber step. 11:26:12 INFO - ##### 11:26:12 INFO - Running pre-action listener: _resource_record_pre_action 11:26:12 INFO - Running main action method: clobber 11:26:12 INFO - rmtree: /builds/slave/test/build 11:26:12 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:26:13 INFO - Running post-action listener: _resource_record_post_action 11:26:13 INFO - ##### 11:26:13 INFO - ##### Running read-buildbot-config step. 11:26:13 INFO - ##### 11:26:13 INFO - Running pre-action listener: _resource_record_pre_action 11:26:13 INFO - Running main action method: read_buildbot_config 11:26:13 INFO - Using buildbot properties: 11:26:13 INFO - { 11:26:13 INFO - "project": "", 11:26:13 INFO - "product": "firefox", 11:26:13 INFO - "script_repo_revision": "production", 11:26:13 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 11:26:13 INFO - "repository": "", 11:26:13 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 11:26:13 INFO - "buildid": "20160517085230", 11:26:13 INFO - "pgo_build": "True", 11:26:13 INFO - "basedir": "/builds/slave/test", 11:26:13 INFO - "buildnumber": 14, 11:26:13 INFO - "slavename": "talos-linux64-ix-038", 11:26:13 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 11:26:13 INFO - "platform": "ubuntu64_hw", 11:26:13 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 11:26:13 INFO - "branch": "mozilla-beta", 11:26:13 INFO - "repo_path": "releases/mozilla-beta", 11:26:13 INFO - "revision": "fb923f1876f55311ba595c7af364f4396e8595f6", 11:26:13 INFO - "stage_platform": "linux64-pgo", 11:26:13 INFO - "builduid": "96e9bcea91ac4aa78169716722e30437", 11:26:13 INFO - "slavebuilddir": "test" 11:26:13 INFO - } 11:26:13 INFO - Found installer url https://queue.taskcluster.net/v1/task/EWBTWRiQSqaI4to2tTLoHw/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2. 11:26:13 INFO - Running post-action listener: _resource_record_post_action 11:26:13 INFO - ##### 11:26:13 INFO - ##### Running download-and-extract step. 11:26:13 INFO - ##### 11:26:13 INFO - Running pre-action listener: _resource_record_pre_action 11:26:13 INFO - Running main action method: download_and_extract 11:26:13 INFO - mkdir: /builds/slave/test/build/tests 11:26:13 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')]} 11:26:13 INFO - https://queue.taskcluster.net/v1/task/EWBTWRiQSqaI4to2tTLoHw/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 11:26:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EWBTWRiQSqaI4to2tTLoHw/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.test_packages.json 11:26:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EWBTWRiQSqaI4to2tTLoHw/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.test_packages.json 11:26:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EWBTWRiQSqaI4to2tTLoHw/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.test_packages.json 11:26:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EWBTWRiQSqaI4to2tTLoHw/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 11:26:13 INFO - Downloaded 1412 bytes. 11:26:13 INFO - Reading from file /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.test_packages.json 11:26:13 INFO - Using the following test package requirements: 11:26:13 INFO - {u'common': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip'], 11:26:13 INFO - u'cppunittest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 11:26:13 INFO - u'firefox-47.0.en-US.linux-x86_64.cppunittest.tests.zip'], 11:26:13 INFO - u'gtest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 11:26:13 INFO - u'firefox-47.0.en-US.linux-x86_64.gtest.tests.zip'], 11:26:13 INFO - u'jittest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 11:26:13 INFO - u'jsshell-linux-x86_64.zip'], 11:26:13 INFO - u'mochitest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 11:26:13 INFO - u'firefox-47.0.en-US.linux-x86_64.mochitest.tests.zip'], 11:26:13 INFO - u'mozbase': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip'], 11:26:13 INFO - u'reftest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 11:26:13 INFO - u'firefox-47.0.en-US.linux-x86_64.reftest.tests.zip'], 11:26:13 INFO - u'talos': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 11:26:13 INFO - u'firefox-47.0.en-US.linux-x86_64.talos.tests.zip'], 11:26:13 INFO - u'web-platform': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 11:26:13 INFO - u'firefox-47.0.en-US.linux-x86_64.web-platform.tests.zip'], 11:26:13 INFO - u'webapprt': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip'], 11:26:13 INFO - u'xpcshell': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 11:26:13 INFO - u'firefox-47.0.en-US.linux-x86_64.xpcshell.tests.zip']} 11:26:13 INFO - Downloading packages: [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:26:13 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')]} 11:26:13 INFO - https://queue.taskcluster.net/v1/task/EWBTWRiQSqaI4to2tTLoHw/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:26:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EWBTWRiQSqaI4to2tTLoHw/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 11:26:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EWBTWRiQSqaI4to2tTLoHw/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 11:26:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EWBTWRiQSqaI4to2tTLoHw/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 11:26:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EWBTWRiQSqaI4to2tTLoHw/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:26:14 INFO - Downloaded 23364815 bytes. 11:26:14 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:26:14 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 11:26:16 INFO - Return code: 0 11:26:16 INFO - Downloading packages: [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', u'firefox-47.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 11:26:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:26:16 INFO - https://queue.taskcluster.net/v1/task/EWBTWRiQSqaI4to2tTLoHw/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:26:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EWBTWRiQSqaI4to2tTLoHw/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 11:26:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EWBTWRiQSqaI4to2tTLoHw/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 11:26:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EWBTWRiQSqaI4to2tTLoHw/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 11:26:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EWBTWRiQSqaI4to2tTLoHw/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:26:17 INFO - Downloaded 23364815 bytes. 11:26:18 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:26:18 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 11:26:19 INFO - Return code: 0 11:26:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:26:19 INFO - https://queue.taskcluster.net/v1/task/EWBTWRiQSqaI4to2tTLoHw/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 11:26:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EWBTWRiQSqaI4to2tTLoHw/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip 11:26:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EWBTWRiQSqaI4to2tTLoHw/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip 11:26:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EWBTWRiQSqaI4to2tTLoHw/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip 11:26:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EWBTWRiQSqaI4to2tTLoHw/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 11:26:20 INFO - Downloaded 10845194 bytes. 11:26:20 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:26:20 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 11:26:21 INFO - Return code: 0 11:26:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:26:21 INFO - https://queue.taskcluster.net/v1/task/EWBTWRiQSqaI4to2tTLoHw/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 11:26:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EWBTWRiQSqaI4to2tTLoHw/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 11:26:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EWBTWRiQSqaI4to2tTLoHw/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 11:26:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EWBTWRiQSqaI4to2tTLoHw/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 11:26:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EWBTWRiQSqaI4to2tTLoHw/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 11:26:23 INFO - Downloaded 53798670 bytes. 11:26:23 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/EWBTWRiQSqaI4to2tTLoHw/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 11:26:23 INFO - mkdir: /builds/slave/test/properties 11:26:23 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:26:23 INFO - Writing to file /builds/slave/test/properties/build_url 11:26:23 INFO - Contents: 11:26:23 INFO - build_url:https://queue.taskcluster.net/v1/task/EWBTWRiQSqaI4to2tTLoHw/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 11:26:24 INFO - Running post-action listener: _resource_record_post_action 11:26:24 INFO - Running post-action listener: set_extra_try_arguments 11:26:24 INFO - ##### 11:26:24 INFO - ##### Running populate-webroot step. 11:26:24 INFO - ##### 11:26:24 INFO - Running pre-action listener: _resource_record_pre_action 11:26:24 INFO - Running main action method: populate_webroot 11:26:24 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:26:24 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:26:24 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:26:24 INFO - '--tppagecycles', 11:26:24 INFO - '7'], 11:26:24 INFO - 'tests': ['tsvgm']}}, 11:26:24 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 11:26:24 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 11:26:24 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:26:24 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 11:26:24 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 11:26:24 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:26:24 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:26:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:26:24 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:26:24 INFO - 'talos_options': ['--e10s'], 11:26:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:26:24 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:26:24 INFO - 'tests': ['damp', 'tps']}, 11:26:24 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:26:24 INFO - 'talos_options': ['--e10s'], 11:26:24 INFO - 'tests': ['damp', 'tps']}, 11:26:24 INFO - 'g3': {'tests': ['dromaeo_dom']}, 11:26:24 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:26:24 INFO - 'other': {'tests': ['a11yr', 11:26:24 INFO - 'ts_paint', 11:26:24 INFO - 'tpaint', 11:26:24 INFO - 'sessionrestore', 11:26:24 INFO - 'sessionrestore_no_auto_restore', 11:26:24 INFO - 'tabpaint']}, 11:26:24 INFO - 'other-e10s': {'talos_options': ['--e10s'], 11:26:24 INFO - 'tests': ['a11yr', 11:26:24 INFO - 'ts_paint', 11:26:24 INFO - 'tpaint', 11:26:24 INFO - 'sessionrestore', 11:26:24 INFO - 'sessionrestore_no_auto_restore', 11:26:24 INFO - 'tabpaint']}, 11:26:24 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 11:26:24 INFO - 'tests': ['a11yr', 11:26:24 INFO - 'ts_paint', 11:26:24 INFO - 'tpaint', 11:26:24 INFO - 'sessionrestore', 11:26:24 INFO - 'sessionrestore_no_auto_restore', 11:26:24 INFO - 'tabpaint']}, 11:26:24 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 11:26:24 INFO - 'tests': ['a11yr', 11:26:24 INFO - 'ts_paint', 11:26:24 INFO - 'tpaint', 11:26:24 INFO - 'sessionrestore', 11:26:24 INFO - 'sessionrestore_no_auto_restore', 11:26:24 INFO - 'tabpaint']}, 11:26:24 INFO - 'other_l64': {'tests': ['a11yr', 11:26:24 INFO - 'ts_paint', 11:26:24 INFO - 'tpaint', 11:26:24 INFO - 'sessionrestore', 11:26:24 INFO - 'sessionrestore_no_auto_restore', 11:26:24 INFO - 'tabpaint']}, 11:26:24 INFO - 'other_nol64': {'tests': ['a11yr', 11:26:24 INFO - 'ts_paint', 11:26:24 INFO - 'tpaint', 11:26:24 INFO - 'sessionrestore', 11:26:24 INFO - 'sessionrestore_no_auto_restore', 11:26:24 INFO - 'tabpaint']}, 11:26:24 INFO - 'svgr': {'tests': ['tsvgx', 11:26:24 INFO - 'tsvgr_opacity', 11:26:24 INFO - 'tart', 11:26:24 INFO - 'tscrollx', 11:26:24 INFO - 'cart']}, 11:26:24 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 11:26:24 INFO - 'tests': ['tsvgx', 11:26:24 INFO - 'tsvgr_opacity', 11:26:24 INFO - 'tart', 11:26:24 INFO - 'tscrollx', 11:26:24 INFO - 'cart']}, 11:26:24 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:26:24 INFO - 'tests': ['tp5o']}, 11:26:24 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:26:24 INFO - 'talos_options': ['--e10s'], 11:26:24 INFO - 'tests': ['tp5o']}, 11:26:24 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:26:24 INFO - 'talos_options': ['--xperf_path', 11:26:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:26:24 INFO - 'tests': ['tp5n']}, 11:26:24 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:26:24 INFO - 'talos_options': ['--e10s', 11:26:24 INFO - '--xperf_path', 11:26:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:26:24 INFO - 'tests': ['tp5n']}}, 11:26:24 INFO - 'talos.zip': {'path': '', 11:26:24 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:26:24 INFO - Running post-action listener: _resource_record_post_action 11:26:24 INFO - ##### 11:26:24 INFO - ##### Running create-virtualenv step. 11:26:24 INFO - ##### 11:26:24 INFO - Running pre-action listener: _resource_record_pre_action 11:26:24 INFO - Running main action method: create_virtualenv 11:26:24 INFO - Creating virtualenv /builds/slave/test/build/venv 11:26:24 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 11:26:24 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:26:24 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:26:24 INFO - Using real prefix '/usr' 11:26:24 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:26:24 INFO - Installing distribute.............................................................................................................................................................................................done. 11:26:26 INFO - Installing pip.................done. 11:26:26 INFO - Return code: 0 11:26:26 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:26:26 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')]} 11:26:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:26:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:26:26 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')]} 11:26:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:26:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:26:26 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 0x7f72d4fb7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bc68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c93410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d22160>, '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 0x2d23060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d234f0>, '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': '8783db0840cc980e80bb0bd400000236-1463509571.83882-1470594797', '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 11:26:26 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 11:26:26 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 11:26:26 INFO - Using env: {'DISPLAY': ':0', 11:26:26 INFO - 'HOME': '/home/cltbld', 11:26:26 INFO - 'LANG': 'en_US.UTF-8', 11:26:26 INFO - 'LANGUAGE': 'en_US:en', 11:26:26 INFO - 'LOGNAME': 'cltbld', 11:26:26 INFO - 'MAIL': '/var/mail/cltbld', 11:26:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:26:26 INFO - 'MOZ_NO_REMOTE': '1', 11:26:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:26:26 INFO - 'NO_EM_RESTART': '1', 11:26:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:26:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:26:26 INFO - 'PWD': '/builds/slave/test', 11:26:26 INFO - 'SHELL': '/bin/bash', 11:26:26 INFO - 'SHLVL': '1', 11:26:26 INFO - 'TERM': 'linux', 11:26:26 INFO - 'TMOUT': '86400', 11:26:26 INFO - 'USER': 'cltbld', 11:26:26 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1463509571.83882-1470594797', 11:26:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:26:26 INFO - '_': '/tools/buildbot/bin/python'} 11:26:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:26:26 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 11:26:26 INFO - Cleaning up... 11:26:26 INFO - Return code: 0 11:26:26 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 11:26:26 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')]} 11:26:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:26:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:26:26 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')]} 11:26:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:26:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:26:26 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 0x7f72d4fb7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bc68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c93410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d22160>, '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 0x2d23060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d234f0>, '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': '8783db0840cc980e80bb0bd400000236-1463509571.83882-1470594797', '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 11:26:26 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 11:26:26 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 11:26:26 INFO - Using env: {'DISPLAY': ':0', 11:26:26 INFO - 'HOME': '/home/cltbld', 11:26:26 INFO - 'LANG': 'en_US.UTF-8', 11:26:26 INFO - 'LANGUAGE': 'en_US:en', 11:26:26 INFO - 'LOGNAME': 'cltbld', 11:26:26 INFO - 'MAIL': '/var/mail/cltbld', 11:26:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:26:26 INFO - 'MOZ_NO_REMOTE': '1', 11:26:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:26:26 INFO - 'NO_EM_RESTART': '1', 11:26:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:26:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:26:26 INFO - 'PWD': '/builds/slave/test', 11:26:26 INFO - 'SHELL': '/bin/bash', 11:26:26 INFO - 'SHLVL': '1', 11:26:26 INFO - 'TERM': 'linux', 11:26:26 INFO - 'TMOUT': '86400', 11:26:26 INFO - 'USER': 'cltbld', 11:26:26 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1463509571.83882-1470594797', 11:26:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:26:26 INFO - '_': '/tools/buildbot/bin/python'} 11:26:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:26:27 INFO - Downloading/unpacking psutil>=0.7.1 11:26:27 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 11:26:27 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 11:26:27 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 11:26:27 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 11:26:27 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 11:26:27 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 11:26:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:26:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:26:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:26:29 INFO - Installing collected packages: psutil 11:26:29 INFO - Running setup.py install for psutil 11:26:29 INFO - building 'psutil._psutil_linux' extension 11:26:29 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 11:26:29 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 11:26:29 INFO - building 'psutil._psutil_posix' extension 11:26:29 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 11:26:29 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 11:26:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:26:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:26:29 INFO - Successfully installed psutil 11:26:29 INFO - Cleaning up... 11:26:29 INFO - Return code: 0 11:26:29 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 11:26: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')]} 11:26:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:26:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:26: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')]} 11:26:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:26:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:26:29 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 0x7f72d4fb7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bc68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c93410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d22160>, '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 0x2d23060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d234f0>, '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': '8783db0840cc980e80bb0bd400000236-1463509571.83882-1470594797', '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 11:26:29 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 11:26:29 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 11:26:29 INFO - Using env: {'DISPLAY': ':0', 11:26:29 INFO - 'HOME': '/home/cltbld', 11:26:29 INFO - 'LANG': 'en_US.UTF-8', 11:26:29 INFO - 'LANGUAGE': 'en_US:en', 11:26:29 INFO - 'LOGNAME': 'cltbld', 11:26:29 INFO - 'MAIL': '/var/mail/cltbld', 11:26:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:26:29 INFO - 'MOZ_NO_REMOTE': '1', 11:26:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:26:29 INFO - 'NO_EM_RESTART': '1', 11:26:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:26:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:26:29 INFO - 'PWD': '/builds/slave/test', 11:26:29 INFO - 'SHELL': '/bin/bash', 11:26:29 INFO - 'SHLVL': '1', 11:26:29 INFO - 'TERM': 'linux', 11:26:29 INFO - 'TMOUT': '86400', 11:26:29 INFO - 'USER': 'cltbld', 11:26:29 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1463509571.83882-1470594797', 11:26:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:26:29 INFO - '_': '/tools/buildbot/bin/python'} 11:26:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:26:29 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 11:26:29 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 11:26:29 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 11:26:29 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 11:26:29 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 11:26:29 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 11:26:29 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 11:26:31 INFO - Downloading mozsystemmonitor-0.0.tar.gz 11:26:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:26:31 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 11:26:31 INFO - Installing collected packages: mozsystemmonitor 11:26:31 INFO - Running setup.py install for mozsystemmonitor 11:26:31 INFO - Successfully installed mozsystemmonitor 11:26:31 INFO - Cleaning up... 11:26:31 INFO - Return code: 0 11:26:31 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:26:31 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')]} 11:26:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:26:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:26:31 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')]} 11:26:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:26:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:26:31 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 0x7f72d4fb7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bc68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c93410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d22160>, '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 0x2d23060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d234f0>, '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': '8783db0840cc980e80bb0bd400000236-1463509571.83882-1470594797', '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 11:26:31 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 11:26:31 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 11:26:31 INFO - Using env: {'DISPLAY': ':0', 11:26:31 INFO - 'HOME': '/home/cltbld', 11:26:31 INFO - 'LANG': 'en_US.UTF-8', 11:26:31 INFO - 'LANGUAGE': 'en_US:en', 11:26:31 INFO - 'LOGNAME': 'cltbld', 11:26:31 INFO - 'MAIL': '/var/mail/cltbld', 11:26:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:26:31 INFO - 'MOZ_NO_REMOTE': '1', 11:26:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:26:31 INFO - 'NO_EM_RESTART': '1', 11:26:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:26:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:26:31 INFO - 'PWD': '/builds/slave/test', 11:26:31 INFO - 'SHELL': '/bin/bash', 11:26:31 INFO - 'SHLVL': '1', 11:26:31 INFO - 'TERM': 'linux', 11:26:31 INFO - 'TMOUT': '86400', 11:26:31 INFO - 'USER': 'cltbld', 11:26:31 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1463509571.83882-1470594797', 11:26:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:26:31 INFO - '_': '/tools/buildbot/bin/python'} 11:26:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:26:32 INFO - Downloading/unpacking blobuploader==1.2.4 11:26:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:26:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:26:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:26:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:26:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:26:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:26:33 INFO - Downloading blobuploader-1.2.4.tar.gz 11:26:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:26:34 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:26:34 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 11:26:34 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 11:26:34 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 11:26:34 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 11:26:34 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 11:26:34 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 11:26:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:26:34 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:26:34 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 11:26:34 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 11:26:34 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 11:26:34 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 11:26:34 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 11:26:34 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 11:26:34 INFO - Downloading docopt-0.6.1.tar.gz 11:26:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:26:34 INFO - Installing collected packages: blobuploader, requests, docopt 11:26:34 INFO - Running setup.py install for blobuploader 11:26:34 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:26:34 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:26:34 INFO - Running setup.py install for requests 11:26:35 INFO - Running setup.py install for docopt 11:26:35 INFO - Successfully installed blobuploader requests docopt 11:26:35 INFO - Cleaning up... 11:26:35 INFO - Return code: 0 11:26:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:26:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:26:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:26:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:26:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:26:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:26:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:26:35 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 0x7f72d4fb7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bc68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c93410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d22160>, '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 0x2d23060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d234f0>, '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': '8783db0840cc980e80bb0bd400000236-1463509571.83882-1470594797', '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 11:26:35 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 11:26:35 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 11:26:35 INFO - Using env: {'DISPLAY': ':0', 11:26:35 INFO - 'HOME': '/home/cltbld', 11:26:35 INFO - 'LANG': 'en_US.UTF-8', 11:26:35 INFO - 'LANGUAGE': 'en_US:en', 11:26:35 INFO - 'LOGNAME': 'cltbld', 11:26:35 INFO - 'MAIL': '/var/mail/cltbld', 11:26:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:26:35 INFO - 'MOZ_NO_REMOTE': '1', 11:26:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:26:35 INFO - 'NO_EM_RESTART': '1', 11:26:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:26:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:26:35 INFO - 'PWD': '/builds/slave/test', 11:26:35 INFO - 'SHELL': '/bin/bash', 11:26:35 INFO - 'SHLVL': '1', 11:26:35 INFO - 'TERM': 'linux', 11:26:35 INFO - 'TMOUT': '86400', 11:26:35 INFO - 'USER': 'cltbld', 11:26:35 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1463509571.83882-1470594797', 11:26:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:26:35 INFO - '_': '/tools/buildbot/bin/python'} 11:26:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:26:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:26:35 INFO - Running setup.py (path:/tmp/pip-of4Pgi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:26:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:26:35 INFO - Running setup.py (path:/tmp/pip-lMX3Xi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:26:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:26:35 INFO - Running setup.py (path:/tmp/pip-QKGQic-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:26:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:26:35 INFO - Running setup.py (path:/tmp/pip-5y2bhF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:26:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:26:35 INFO - Running setup.py (path:/tmp/pip-c2bmnV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:26:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:26:35 INFO - Running setup.py (path:/tmp/pip-Ww1UBx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:26:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:26:36 INFO - Running setup.py (path:/tmp/pip-8wzL9Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:26:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:26:36 INFO - Running setup.py (path:/tmp/pip-QlqE2z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:26:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:26:36 INFO - Running setup.py (path:/tmp/pip-sleFZ6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:26:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:26:36 INFO - Running setup.py (path:/tmp/pip-Qej73n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:26:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:26:36 INFO - Running setup.py (path:/tmp/pip-zHMqIA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:26:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:26:36 INFO - Running setup.py (path:/tmp/pip-AclBdc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:26:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:26:36 INFO - Running setup.py (path:/tmp/pip-GbUw2q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:26:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:26:36 INFO - Running setup.py (path:/tmp/pip-q1PSD_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:26:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:26:36 INFO - Running setup.py (path:/tmp/pip-ZrsTRr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:26:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:26:36 INFO - Running setup.py (path:/tmp/pip-66q9nQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:26:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:26:36 INFO - Running setup.py (path:/tmp/pip-Hzb3lp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:26:36 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:26:36 INFO - Running setup.py install for manifestparser 11:26:36 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:26:36 INFO - Running setup.py install for mozcrash 11:26:36 INFO - Running setup.py install for mozdebug 11:26:37 INFO - Running setup.py install for mozdevice 11:26:37 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:26:37 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:26:37 INFO - Running setup.py install for mozfile 11:26:37 INFO - Running setup.py install for mozhttpd 11:26:37 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:26:37 INFO - Running setup.py install for mozinfo 11:26:37 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:26:37 INFO - Running setup.py install for mozInstall 11:26:37 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:26:37 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:26:37 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:26:37 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:26:37 INFO - Running setup.py install for mozleak 11:26:37 INFO - Running setup.py install for mozlog 11:26:37 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:26:37 INFO - Running setup.py install for moznetwork 11:26:37 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:26:37 INFO - Running setup.py install for mozprocess 11:26:38 INFO - Running setup.py install for mozprofile 11:26:38 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:26:38 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:26:38 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:26:38 INFO - Running setup.py install for mozrunner 11:26:38 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:26:38 INFO - Running setup.py install for mozscreenshot 11:26:38 INFO - Running setup.py install for moztest 11:26:38 INFO - Running setup.py install for mozversion 11:26:38 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:26:38 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:26:38 INFO - Cleaning up... 11:26:38 INFO - Return code: 0 11:26:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:26: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')]} 11:26:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:26:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:26: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')]} 11:26:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:26:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:26:38 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 0x7f72d4fb7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bc68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c93410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d22160>, '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 0x2d23060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d234f0>, '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': '8783db0840cc980e80bb0bd400000236-1463509571.83882-1470594797', '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 11:26:38 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 11:26:38 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 11:26:38 INFO - Using env: {'DISPLAY': ':0', 11:26:38 INFO - 'HOME': '/home/cltbld', 11:26:38 INFO - 'LANG': 'en_US.UTF-8', 11:26:38 INFO - 'LANGUAGE': 'en_US:en', 11:26:38 INFO - 'LOGNAME': 'cltbld', 11:26:38 INFO - 'MAIL': '/var/mail/cltbld', 11:26:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:26:38 INFO - 'MOZ_NO_REMOTE': '1', 11:26:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:26:38 INFO - 'NO_EM_RESTART': '1', 11:26:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:26:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:26:38 INFO - 'PWD': '/builds/slave/test', 11:26:38 INFO - 'SHELL': '/bin/bash', 11:26:38 INFO - 'SHLVL': '1', 11:26:38 INFO - 'TERM': 'linux', 11:26:38 INFO - 'TMOUT': '86400', 11:26:38 INFO - 'USER': 'cltbld', 11:26:38 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1463509571.83882-1470594797', 11:26:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:26:38 INFO - '_': '/tools/buildbot/bin/python'} 11:26:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:26:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:26:38 INFO - Running setup.py (path:/tmp/pip-2Q7z_F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:26:38 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)) 11:26:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:26:38 INFO - Running setup.py (path:/tmp/pip-7DuLQj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:26:38 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)) 11:26:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:26:38 INFO - Running setup.py (path:/tmp/pip-7Wm44l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:26:39 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)) 11:26:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:26:39 INFO - Running setup.py (path:/tmp/pip-3AaIJd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:26:39 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)) 11:26:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:26:39 INFO - Running setup.py (path:/tmp/pip-9UAYpt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:26:39 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)) 11:26:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:26:39 INFO - Running setup.py (path:/tmp/pip-VbOP04-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:26:39 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)) 11:26:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:26:39 INFO - Running setup.py (path:/tmp/pip-0NUJBa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:26:39 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)) 11:26:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:26:39 INFO - Running setup.py (path:/tmp/pip-J0pC8o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:26:39 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)) 11:26:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:26:39 INFO - Running setup.py (path:/tmp/pip-2wNfj0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:26:39 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)) 11:26:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:26:39 INFO - Running setup.py (path:/tmp/pip-LWRXfC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:26:39 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)) 11:26:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:26:39 INFO - Running setup.py (path:/tmp/pip-VW3UP8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:26:39 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)) 11:26:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:26:39 INFO - Running setup.py (path:/tmp/pip-y7HiSc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:26:39 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)) 11:26:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:26:39 INFO - Running setup.py (path:/tmp/pip-seJyTh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:26:39 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)) 11:26:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:26:39 INFO - Running setup.py (path:/tmp/pip-pruYNo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:26:39 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)) 11:26:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:26:39 INFO - Running setup.py (path:/tmp/pip-27nlnQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:26:39 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)) 11:26:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:26:39 INFO - Running setup.py (path:/tmp/pip-PG1sJw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:26:39 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)) 11:26:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:26:39 INFO - Running setup.py (path:/tmp/pip-AAao0t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:26:40 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)) 11:26:40 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)) 11:26:40 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)) 11:26:40 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)) 11:26:40 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)) 11:26:40 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)) 11:26:40 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:26:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:26:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:26:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:26:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:26:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:26:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:26:41 INFO - Downloading blessings-1.6.tar.gz 11:26:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:26:41 INFO - Installing collected packages: blessings 11:26:41 INFO - Running setup.py install for blessings 11:26:42 INFO - Successfully installed blessings 11:26:42 INFO - Cleaning up... 11:26:42 INFO - Return code: 0 11:26:42 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:26:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:26:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:26:42 INFO - Reading from file tmpfile_stdout 11:26:42 INFO - Current package versions: 11:26:42 INFO - argparse == 1.2.1 11:26:42 INFO - blessings == 1.6 11:26:42 INFO - blobuploader == 1.2.4 11:26:42 INFO - docopt == 0.6.1 11:26:42 INFO - manifestparser == 1.1 11:26:42 INFO - mozInstall == 1.12 11:26:42 INFO - mozcrash == 0.17 11:26:42 INFO - mozdebug == 0.1 11:26:42 INFO - mozdevice == 0.48 11:26:42 INFO - mozfile == 1.2 11:26:42 INFO - mozhttpd == 0.7 11:26:42 INFO - mozinfo == 0.9 11:26:42 INFO - mozleak == 0.1 11:26:42 INFO - mozlog == 3.1 11:26:42 INFO - moznetwork == 0.27 11:26:42 INFO - mozprocess == 0.22 11:26:42 INFO - mozprofile == 0.28 11:26:42 INFO - mozrunner == 6.11 11:26:42 INFO - mozscreenshot == 0.1 11:26:42 INFO - mozsystemmonitor == 0.0 11:26:42 INFO - moztest == 0.7 11:26:42 INFO - mozversion == 1.4 11:26:42 INFO - psutil == 3.1.1 11:26:42 INFO - requests == 1.2.3 11:26:42 INFO - wsgiref == 0.1.2 11:26:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:26:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:26:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:26:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:26:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:26:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:26:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:26:42 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 0x7f72d4fb7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bc68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c93410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d22160>, '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 0x2d23060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d234f0>, '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': '8783db0840cc980e80bb0bd400000236-1463509571.83882-1470594797', '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 11:26:42 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 11:26:42 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 11:26:42 INFO - Using env: {'DISPLAY': ':0', 11:26:42 INFO - 'HOME': '/home/cltbld', 11:26:42 INFO - 'LANG': 'en_US.UTF-8', 11:26:42 INFO - 'LANGUAGE': 'en_US:en', 11:26:42 INFO - 'LOGNAME': 'cltbld', 11:26:42 INFO - 'MAIL': '/var/mail/cltbld', 11:26:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:26:42 INFO - 'MOZ_NO_REMOTE': '1', 11:26:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:26:42 INFO - 'NO_EM_RESTART': '1', 11:26:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:26:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:26:42 INFO - 'PWD': '/builds/slave/test', 11:26:42 INFO - 'SHELL': '/bin/bash', 11:26:42 INFO - 'SHLVL': '1', 11:26:42 INFO - 'TERM': 'linux', 11:26:42 INFO - 'TMOUT': '86400', 11:26:42 INFO - 'USER': 'cltbld', 11:26:42 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1463509571.83882-1470594797', 11:26:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:26:42 INFO - '_': '/tools/buildbot/bin/python'} 11:26:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:26:42 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)) 11:26:42 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)) 11:26:42 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)) 11:26:42 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)) 11:26:42 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)) 11:26:42 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)) 11:26:42 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)) 11:26:42 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)) 11:26:42 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)) 11:26:42 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)) 11:26:42 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)) 11:26:42 INFO - Cleaning up... 11:26:42 INFO - Return code: 0 11:26:42 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:26:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:26:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:26:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:26:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:26:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:26:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:26:42 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 0x7f72d4fb7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bc68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c93410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d22160>, '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 0x2d23060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d234f0>, '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': '8783db0840cc980e80bb0bd400000236-1463509571.83882-1470594797', '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 11:26:42 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 11:26:42 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 11:26:42 INFO - Using env: {'DISPLAY': ':0', 11:26:42 INFO - 'HOME': '/home/cltbld', 11:26:42 INFO - 'LANG': 'en_US.UTF-8', 11:26:42 INFO - 'LANGUAGE': 'en_US:en', 11:26:42 INFO - 'LOGNAME': 'cltbld', 11:26:42 INFO - 'MAIL': '/var/mail/cltbld', 11:26:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:26:42 INFO - 'MOZ_NO_REMOTE': '1', 11:26:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:26:42 INFO - 'NO_EM_RESTART': '1', 11:26:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:26:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:26:42 INFO - 'PWD': '/builds/slave/test', 11:26:42 INFO - 'SHELL': '/bin/bash', 11:26:42 INFO - 'SHLVL': '1', 11:26:42 INFO - 'TERM': 'linux', 11:26:42 INFO - 'TMOUT': '86400', 11:26:42 INFO - 'USER': 'cltbld', 11:26:42 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1463509571.83882-1470594797', 11:26:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:26:42 INFO - '_': '/tools/buildbot/bin/python'} 11:26:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:26:42 INFO - Downloading/unpacking jsonschema 11:26:42 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 11:26:42 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 11:26:42 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 11:26:42 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 11:26:42 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 11:26:42 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 11:26:44 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:26:44 INFO - Downloading/unpacking functools32 (from jsonschema) 11:26: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 11:26: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 11:26: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 11:26: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 11:26: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 11:26: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 11:26:44 INFO - Downloading functools32-3.2.3-2.tar.gz 11:26:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:26:44 INFO - warning: no files found matching '*.txt' 11:26:44 INFO - no previously-included directories found matching 'build' 11:26:44 INFO - no previously-included directories found matching 'dist' 11:26:44 INFO - no previously-included directories found matching '.git*' 11:26:45 INFO - Installing collected packages: jsonschema, functools32 11:26:45 INFO - Running setup.py install for functools32 11:26:45 INFO - warning: no files found matching '*.txt' 11:26:45 INFO - no previously-included directories found matching 'build' 11:26:45 INFO - no previously-included directories found matching 'dist' 11:26:45 INFO - no previously-included directories found matching '.git*' 11:26:45 INFO - Successfully installed jsonschema functools32 11:26:45 INFO - Cleaning up... 11:26:45 INFO - Return code: 0 11:26:45 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 11:26:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:26:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:26:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:26:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:26:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:26:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:26:45 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 0x7f72d4fb7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bc68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c93410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d22160>, '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 0x2d23060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d234f0>, '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': '8783db0840cc980e80bb0bd400000236-1463509571.83882-1470594797', '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 11:26:45 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 11:26:45 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 11:26:45 INFO - Using env: {'DISPLAY': ':0', 11:26:45 INFO - 'HOME': '/home/cltbld', 11:26:45 INFO - 'LANG': 'en_US.UTF-8', 11:26:45 INFO - 'LANGUAGE': 'en_US:en', 11:26:45 INFO - 'LOGNAME': 'cltbld', 11:26:45 INFO - 'MAIL': '/var/mail/cltbld', 11:26:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:26:45 INFO - 'MOZ_NO_REMOTE': '1', 11:26:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:26:45 INFO - 'NO_EM_RESTART': '1', 11:26:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:26:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:26:45 INFO - 'PWD': '/builds/slave/test', 11:26:45 INFO - 'SHELL': '/bin/bash', 11:26:45 INFO - 'SHLVL': '1', 11:26:45 INFO - 'TERM': 'linux', 11:26:45 INFO - 'TMOUT': '86400', 11:26:45 INFO - 'USER': 'cltbld', 11:26:45 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1463509571.83882-1470594797', 11:26:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:26:45 INFO - '_': '/tools/buildbot/bin/python'} 11:26:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:26:45 INFO - Downloading/unpacking flake8 11:26:45 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 11:26:45 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 11:26:45 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 11:26:45 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 11:26:45 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 11:26:45 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 11:26:47 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 11:26:47 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 11:26: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 11:26: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 11:26: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 11:26: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 11:26: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 11:26: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 11:26:47 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 11:26:47 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 11:26: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 11:26: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 11:26: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 11:26: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 11:26: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 11:26: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 11:26:47 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 11:26: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 11:26: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 11:26: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 11:26: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 11:26: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 11:26: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 11:26:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 11:26:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:26:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:26:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:26:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:26:48 INFO - no previously-included directories found matching 'docs/_build' 11:26:48 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 11:26:48 INFO - Running setup.py install for pep8 11:26:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:26:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:26:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:26:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:26:48 INFO - no previously-included directories found matching 'docs/_build' 11:26:48 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 11:26:48 INFO - Successfully installed flake8 mccabe pyflakes pep8 11:26:48 INFO - Cleaning up... 11:26:48 INFO - Return code: 0 11:26:48 INFO - Running post-action listener: _resource_record_post_action 11:26:48 INFO - Running post-action listener: _start_resource_monitoring 11:26:48 INFO - Starting resource monitoring. 11:26:48 INFO - ##### 11:26:48 INFO - ##### Running install step. 11:26:48 INFO - ##### 11:26:48 INFO - Running pre-action listener: _resource_record_pre_action 11:26:48 INFO - Running main action method: install 11:26:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:26:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:26:48 INFO - Reading from file tmpfile_stdout 11:26:48 INFO - Detecting whether we're running mozinstall >=1.0... 11:26:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:26:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:26:48 INFO - Reading from file tmpfile_stdout 11:26:48 INFO - Output received: 11:26:48 INFO - Usage: mozinstall [options] installer 11:26:48 INFO - Options: 11:26:48 INFO - -h, --help show this help message and exit 11:26:48 INFO - -d DEST, --destination=DEST 11:26:48 INFO - Directory to install application into. [default: 11:26:48 INFO - "/builds/slave/test"] 11:26:48 INFO - --app=APP Application being installed. [default: firefox] 11:26:48 INFO - mkdir: /builds/slave/test/build/application 11:26:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 11:26:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 11:27:01 INFO - Reading from file tmpfile_stdout 11:27:01 INFO - Output received: 11:27:01 INFO - /builds/slave/test/build/application/firefox/firefox 11:27:01 INFO - Running post-action listener: _resource_record_post_action 11:27:01 INFO - ##### 11:27:01 INFO - ##### Running run-tests step. 11:27:01 INFO - ##### 11:27:01 INFO - Running pre-action listener: _resource_record_pre_action 11:27:01 INFO - Running main action method: run_tests 11:27:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:27:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:27:01 INFO - Python 2.7.3 11:27:01 INFO - Return code: 0 11:27:01 INFO - grabbing minidump binary from tooltool 11:27:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:27:01 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 0x2d22160>, '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 0x2d23060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d234f0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:27:01 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 11:27:01 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 11:27:01 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:27:01 INFO - Return code: 0 11:27:01 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:27:01 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:27:01 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:27:01 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:27:01 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:27:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 11:27:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 11:27:02 INFO - Return code: 0 11:27:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/EWBTWRiQSqaI4to2tTLoHw/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-038', '--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 11:27:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/EWBTWRiQSqaI4to2tTLoHw/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-038 --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 11:27:02 INFO - Using env: {'DISPLAY': ':0', 11:27:02 INFO - 'HOME': '/home/cltbld', 11:27:02 INFO - 'LANG': 'en_US.UTF-8', 11:27:02 INFO - 'LANGUAGE': 'en_US:en', 11:27:02 INFO - 'LOGNAME': 'cltbld', 11:27:02 INFO - 'MAIL': '/var/mail/cltbld', 11:27:02 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:27:02 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:27:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:27:02 INFO - 'MOZ_NO_REMOTE': '1', 11:27:02 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:27:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:27:02 INFO - 'NO_EM_RESTART': '1', 11:27:02 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:27:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:27:02 INFO - 'PWD': '/builds/slave/test', 11:27:02 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:27:02 INFO - 'SHELL': '/bin/bash', 11:27:02 INFO - 'SHLVL': '1', 11:27:02 INFO - 'TERM': 'linux', 11:27:02 INFO - 'TMOUT': '86400', 11:27:02 INFO - 'USER': 'cltbld', 11:27:02 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1463509571.83882-1470594797', 11:27:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:27:02 INFO - '_': '/tools/buildbot/bin/python'} 11:27:02 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/EWBTWRiQSqaI4to2tTLoHw/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-038', '--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 11:27:02 INFO - mozversion application_buildid: 20160517085230 11:27:02 INFO - mozversion application_changeset: fb923f1876f55311ba595c7af364f4396e8595f6 11:27:02 INFO - mozversion application_display_name: Firefox 11:27:02 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:27:02 INFO - mozversion application_name: Firefox 11:27:02 INFO - mozversion application_remotingname: firefox 11:27:02 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 11:27:02 INFO - mozversion application_vendor: Mozilla 11:27:02 INFO - mozversion application_version: 47.0 11:27:02 INFO - mozversion platform_buildid: 20160517085230 11:27:02 INFO - mozversion platform_changeset: fb923f1876f55311ba595c7af364f4396e8595f6 11:27:02 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 11:27:02 INFO - mozversion platform_version: 47.0 11:27:02 INFO - using testdate: 1463509622 11:27:02 INFO - actual date: 1463509622 11:27:02 INFO - starting webserver on 'localhost:43872' 11:27:02 INFO - SUITE-START | Running 2 tests 11:27:02 INFO - TEST-START | dromaeo_css 11:27:02 INFO - operating with platform_type : linux_ 11:27:02 INFO - Initialising browser for dromaeo_css test... 11:27:02 INFO - TEST-INFO | started process 26225 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQERq97/profile http://localhost:43872/getInfo.html) 11:27:06 INFO - PROCESS | 26225 | __metrics Screen width/height:1600/1200 11:27:06 INFO - PROCESS | 26225 | colorDepth:24 11:27:06 INFO - PROCESS | 26225 | Browser inner width/height: 1024/697 11:27:06 INFO - PROCESS | 26225 | __metrics 11:27:07 INFO - PROCESS | 26225 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:27:08 INFO - TEST-INFO | 26225: exit 0 11:27:08 INFO - Browser initialized. 11:27:08 INFO - Running cycle 1/1 for dromaeo_css test... 11:27:08 INFO - TEST-INFO | started process 26314 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQERq97/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:27:20 INFO - PROCESS | 26314 | RSS: Main: 139288576 11:27:20 INFO - PROCESS | 26314 | 11:28:11 INFO - PROCESS | 26314 | 1463509691167 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] 11:30:19 INFO - PROCESS | 26314 | Cycle 1(1): loaded http://localhost:43872/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43872/tests/dromaeo/cssquery-ext.html) 11:30:20 INFO - PROCESS | 26314 | RSS: Main: 246587392 11:30:20 INFO - PROCESS | 26314 | 11:33:22 INFO - PROCESS | 26314 | Cycle 1(1): loaded http://localhost:43872/tests/dromaeo/cssquery-ext.html (next: http://localhost:43872/tests/dromaeo/cssquery-jquery.html) 11:33:22 INFO - PROCESS | 26314 | RSS: Main: 227045376 11:33:22 INFO - PROCESS | 26314 | 11:36:24 INFO - PROCESS | 26314 | Cycle 1(1): loaded http://localhost:43872/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43872/tests/dromaeo/cssquery-mootools.html) 11:36:25 INFO - PROCESS | 26314 | RSS: Main: 234938368 11:36:25 INFO - PROCESS | 26314 | 11:39:26 INFO - PROCESS | 26314 | Cycle 1(1): loaded http://localhost:43872/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43872/tests/dromaeo/cssquery-prototype.html) 11:39:27 INFO - PROCESS | 26314 | RSS: Main: 208748544 11:39:27 INFO - PROCESS | 26314 | 11:42:29 INFO - PROCESS | 26314 | Cycle 1(1): loaded http://localhost:43872/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43872/tests/dromaeo/cssquery-yui.html) 11:42:30 INFO - PROCESS | 26314 | RSS: Main: 208101376 11:42:30 INFO - PROCESS | 26314 | 11:45:32 INFO - PROCESS | 26314 | Cycle 1(1): loaded http://localhost:43872/tests/dromaeo/cssquery-yui.html (next: http://localhost:43872/tests/dromaeo/cssquery-dojo.html) 11:45:32 INFO - PROCESS | 26314 | RSS: Main: 258326528 11:45:32 INFO - PROCESS | 26314 | 11:45:32 INFO - PROCESS | 26314 | __start_tp_report 11:45:32 INFO - PROCESS | 26314 | _x_x_mozilla_page_load 11:45:32 INFO - PROCESS | 26314 | _x_x_mozilla_page_load_details 11:45:32 INFO - PROCESS | 26314 | |i|pagename|runs| 11:45:32 INFO - PROCESS | 26314 | |0;dojo.html;3259.690329418705;3360.714339281161;3370.6629337066297;3378.695917367438;3405.4381027130516;5358.705271210087;5377.8117765878205;5382.730863456826;5398.541124004454;5411.404745477994;5359.517643412092;5378.381486129097;5401.729913504319;5402.945970540293;5411.675299482034;4747.501512341206;4906.19047857104;4909.067277217335;4951.900961980758;4999.60003199745;4834.540718631724;4907.067657145149;4936.58039066678;4937.901241975158;4967.329410529586;4828.97585512072;4917.532834380728;4933.827316043939;4940.529735132433;4954.925676114861;4938.3580134582635;4991.32617096691;4995.625328100389;5006.949930500685;5011.774470148834;4758.405199350082;4848.248521479177;4902.2156454967035;4930.186519224324;4941.950580494185;5167.431582525919;5170.121079416508;5184.144616138333;5185.040767458032;5210.895782084375;5744.224529688522;5746.224259724925;5757.913631295534;5760.654360738369;5788.131780232957;5667.4049224831215;5676.460736230093;5736.627119237236;5787.421257874179;5811.418858114154;5427.267318911936;5428.5928555358505;5430.15832545956;5431.076716958087;5431.83704488866;5756.769729210869;5859.414058594107;5912.76348946046;5917.142014407973;5920.940790592125;5741.684207368635;5797;5804.970975145097;5824.271966004249;5841.41585841421;5799.594028418054;5802.245708057925;5802.47777700009;5804.477597016289;5807.245058142415;5546.77812887488;5747.770089196385;5750.4249575042995;5762.94237057624;5766.913496297559;5776.595638305278;5784.652920824764;5789.102689083199;5794.913076303858;5828.388019257917;4351.19502891966;4363.781810909441;4378.0806030733265;4380.364847097153;4405.03089320349;3804.239152169577;3909.0618251619408;3961.58403367648;3969.980150099231;3978.4430179774854;5575.721213939287;5579.246801681802;5593.216949627055;5600.187972743929;5605.243292155588;5877.5591830612875;5912.290525137011;5912.645241285537;5913.674747888907;5915.024021036566;5357.223202635596;5380.542653874386;5472.288602481652;5475.753591088411;5568.081266590967;4950.801967921243;4997.550220480101;4998.550130488274;4999.825006124768;5028.698278103326;5960.76156953717;5994.430529099728;6033.095035744674;6038.607490513103;6039.396060393926;5673;5744.281964754406;5800.1299805029585;5801.1878337032;5810.738516766671;6013.458788709037;6016.578839481194;6028.758849645965;6031.849203769941;6036.456718895321;5543.77824887;5728.455796699307;5730.942690573208;5731.484166425042;5731.627444216113;5788.971055144866;5839.912401314069;5849.181114643869;5853.736581853912;5873.207117039145;5647.971760141338;5657.632253903483;5676.829695109153;5681.403452637579;5686.715664216856;5547.0570003098765;5619.297587801525;5671.206031155559;5673;5674.06377947634;5470.070088085115;5504.311961004874;5518.834434966958;5524.861878453071;5544.445555444423;5607.80372686954;5630.60585758993;5642.351129620146;5644.209810626434;5646.576506762091;5446.455354464521;5530.032244357302;5555.30558680165;5562.91655625174;5638.295213098363 11:45:32 INFO - PROCESS | 26314 | |1;ext.html;527.2486706443318;546.2243614068026;563.6702529020522;564.7938502446606;648.1185587600864;30831.229219269528;39826.60173398265;39858.60141398585;39909;40026.599734002615;43223;43812.3428148578;43832.56167438324;43862;43875;8730.952285725705;8954.552272386387;8956.776080597972;8965.103489651015;8966.0585638508;8831.425957312786;8988.415752976036;8990.68532601359;8991.95504022479;8994.10058994102;8917.152870477294;9253.907460925406;9265.814683706321;9266.768330791716;9274.48990305533;9094.86357704635;9120.17918387345;9184.448933064004;9204.95397523008;9205.907940920606;8958.104189581056;9084.8637270441;9104.13510716481;9106.27149828012;9114.270858331383;43122.13755724899;43430.348544771856;43574.56425435768;43583.34624980628;43651.34522982158;3812.1041555234497;3922.882313530599;4594.402727645384;4674.065186962621;4676.158291507527;33078.50382244268;33273;33636.6636333636;33947.321053579035;33999.83000085009;4090.8159132839096;4093.8771836844644;4131.084596217067;4187.371894215861;4238.491381034265;279088;280472;280540;280858.99999999796;282562;45938.31092533615;61074.69462652658;62197.37802621916;62414.375856241764;62452.375476245565;43796.3430548542;44074;44116.3382549262;44159.33760993523;44175.558244417145;15227.390904363923;15423.383064677288;15447.38210471591;15449.84550154484;15478.922605387126;12706.872931270755;12851.550195743292;12858.549950751678;12864.935675321563;12879.42042608085;15074.170920599254;15110;15567.221638918008;15637.68724625501;15710;5795.594308398456;5821.7380217890295;5827.329857066492;5950.4049595041015;6065.272167339947;898.3172788680519;987.53585814667;995.6963126246565;1037.1495373793568;1086.21792309537;29968.40063198724;30166.396672066436;30177.396452070836;30406;30483.39033219323;1034.2398337222135;1087.1465899269035;1158.3108050709814;1167.4629670351733;1214.1622280626339;13919.373628186553;13935.163890166623;14022.368993395321;14365.92817035929;14408.567742967727;346556;357728;359595;359814;360589;56316.59208519738;57197.428025720044;57307.71346143326;57584.424155758745;57637;1322.3652646729624;1411.6470882279225;1453.738327101132;1462.5466105507326;1478.719043381754;28057.158285251477;29358;29380.41239175162;30171.698283017766;30275.394492110474;45052.549474506144;45270.54729452663;45449;45524.54475455203;45580.31629525493;235033;235169;235271;236472;237476;30249.697503025567;34851.4772278411;35048.47427288542;35120;35211.64788352186;39872.601273988046;40422.39366409565;40471.19057618772;41491.170176596905;41706.79146604247;36677.26645467022;37284;37329.62670373262;37363.813180933925;37651.81174094112;36117.27765444729;41948.37077443902;44354.77822610866;44429.555704442544;45317.32024019576;38884.61115388923;39673;39733.403998940616;39734.80132599318;39955.200895982496;33311.167220819676;33573;34176.14559636029;34328.48507272343;34510;25675.871620641778;26175.738242618092;26337.809737050546;26370.868145659148;26614.866925665247 11:45:32 INFO - PROCESS | 26314 | |2;jquery.html;370.84053856841564;371.20747204717935;374.9043993781586;377.3566069850904;378.47203151603514;17564.297428102876;18208.271669133235;19451.708224376645;19491.220351185937;19503.12235949382;17858.374956876512;17936.730949035777;18483.81516184838;18514.907425462887;18519.81480185198;5540.833774986747;5734.913976290359;5769.942300576982;5771.913421298684;5776.59563830532;4219.43037689911;5699.971500142494;5998.7600495980105;6237.750489980395;6260.248770147566;6192.318844927055;6197.783077592285;6216.782412615559;6227.065940108997;6231;5896;6321.936780632181;6337.524685648572;6341.143945567335;6342.619442833398;3877.7673339599714;5335.946640533583;5527.419620939824;5548.306461692288;5611.9438805612235;22168.667469987962;22185.223517176822;22272.554548909095;22789.544209115724;22804.885975570018;2231.129859354853;2338.3101984914492;2361.9645705314433;2380.7143142822974;2403.8076953843824;13813.240271785047;13830.515931942333;13999.480612876801;14112.364943577564;14167.78748318776;1916.2430839818194;1944.9708254376196;1972.3885595465308;1980.386080315107;2029.3201777404588;62055.68972155156;62880.37119628791;63197.36802631961;63871.722565548895;64548.3545164547;9914.40513569188;10270.486475676187;10418.270721049605;10501.632442864464;10539.63111291101;14687.55937321882;14706.779398309034;14781.852181478047;14801.925990369979;14804.407823686932;8323;8408.537530435762;8469.5341756204;8525.57372131391;8580.828383432296;8454.577271136419;8479.48101537855;8488.872666910001;8512.957435212784;8561.700340488052;5987.6108052976415;6129.693515324216;6175.413335733098;6223.408776166257;6251.687415629201;1792;1839.3697013270883;1895.5642000029895;1907.7949045603518;1935.419374187738;926.7266156483853;1003.8092762375126;1063.2929102146986;1110.5890820396505;1162.7441962768178;17162.056086915338;17277.65444691099;17914.28342866297;17951.910240448975;18404.35584754527;992.3847214726916;995.1044060345747;1047.5286121245317;1061.4639606998571;1138.021301680554;10277.486125693686;10711.036006759428;10713.517891694892;10749.408782517037;10800.135989120852;465530;470041;497479;503452;503557;67289;67693.32306676969;69812;70464.64767676129;70612;1076.51556799439;1087.9619213327496;1089.3355053417567;1101.7576133250673;1102.2559772153925;16101.355945762038;16120;16131.193440327703;16230.594235144215;16379.59051023734;31707.365852683277;33089.50365744468;33932;34113.31773364569;34335.31329373349;44879.10241795211;45269.32096018628;46326;46368.536314636425;46909.76545117253;7806.4925779824125;8257.587120643824;8331.375146864131;8595.226429621363;8785.077566855389;7004.3696067354185;9769.706908792748;9953.502324883872;12198.634040978784;12399;10426.530806113591;10476.109530689977;10554.472276385997;10644.201684873511;10675.679729608124;10640.095591874468;10703.090237329603;10736.67789966271;10850.0777433919;10903.127749780157;10168.593256269667;10684.626038088629;10799.460026998462;10821.296615719953;10827.837582436427;8230.465019773696;8294.543800091053;8303.6678532858;8471.279941205066;8549.700760473354;9344.906550934404;10183.083522482715;10418.479076046016;10560.419176945341;10599.735006624896 11:45:32 INFO - PROCESS | 26314 | |3;mootools.html;1432.856714328568;1547;1559.539935718963;1793.6861049316374;1927.9036048197595;7825.139234684188;7969.960150199248;8010.279074883259;8024.117347091816;8028.036635603736;7815.921840781604;7972.601369931509;7976.960115199416;7982.560959147245;7983.281504664579;2392.4258178037235;2414.0947144820693;2415.52897185049;2416.1905761569806;2417.2748175547354;2424.745401732819;2427;2464.199135281032;2475.418276704973;2477.665515155458;2398.364433425144;2413.2760171948435;2421.7578242175728;2427.174760581402;2427.174760581402;2433.634954756783;2453.6932883389577;2465.235776909164;2466.235467005234;2472.6167444046023;2396.5566370221563;2455.3247856839334;2466.679331686887;2466.9753302467107;2477.5416547938507;8185.631646575918;8240.8351832963;8251.133630968781;8251.587420628945;8260.545669988149;4933.383327084114;5029.899402011939;5052.9242061369105;5065.392152941634;5066.36670416198;3282.163048422637;3298.224917144469;3335.8999230022896;3338.3990881641294;3358.630550639452;1115.9944200279028;1137.8236373362142;1143.7598104398087;1145.9942700286529;1154.4112502623639;11331.263467874644;11384.146189035773;11392.772144557146;11400.486978086006;11405.600803971822;4496.3705081288645;4514.8938510065245;4560.977195114003;4578.496365399803;4626.8149274028665;9721.368111072758;9724.70825875225;9726.659566915125;9743.853842192373;9748.415095094317;5153.639245252796;5165.302684137669;5165.767540460688;5165.974170129125;5170;3949.229900169497;4402.955970440319;4516.119356725407;4517.909641807146;4658.277966915133;3800.3349413853016;3857.267119247334;3863.459115723801;3886.9222615547533;3910.511186101737;1244.6826059354808;1261.6278197931633;1267.4486598329756;1277.6614197237739;1277.8849903508542;1435.4617018618019;1453.985460145385;1461.5103940180159;1474.8820094392422;1503.225838693074;7871.409644276702;7880.64537095832;7914.089879663912;7925.762227133196;7931.603419828985;549.6344930621173;551.1539786427894;554.1217170784352;562.3859523168533;563.4815969308246;5974.820755377345;5976;5988.700564971734;6006.159137720722;6080.179175811298;9768.755781105529;10127.291089623803;10135.391876487434;10235.692929212135;10256.12822910046;9768.267379946532;9935.801283974424;9947.651832185838;10000.299979001546;10090.949545252226;7837.568933708701;7919.208079192034;7944.721934732373;7986.121526632066;8000.719974800854;7419.07261592301;7481.700731970878;7608.0489938757655;7650.961745191238;7656.540607563564;8892.555372231232;8952.14954579314;9023.052579479323;9144.314176436927;9194.632214711337;9046.140616641409;9147.268218542367;9147.542622868697;9183.494907780136;9373.718788436357;6369.808905732835;6512.120863683342;6517.120188774455;7383.2985866342615;7459.179490256176;7731.536107833548;8012.599370031592;8035.196480351918;8037.598120094089;8043.396745244013;7087;7239.638018099179;7281.235470275545;7295.197528271779;7367.4106071515225;7157.534760240567;7192.820179495345;7256.0567126273245;7278.636068196463;7322.96338518304;7434.219406962191;7461.030066091591;7494.437917156126;7495.887561686688;7496.62516874165;6766.120404347404;6830.077939478306;6831.69257383409;6832.419244364086;6849.931500684929;6643.933560664332;6997.265287144776;7005;7015.298470152944;7017.543859649107 11:45:32 INFO - PROCESS | 26314 | |4;prototype.html;358.50168266110103;365.84268764431295;366.3040223575207;366.40459253712714;369.9426588878725;5922.58541902067;5938.821835344941;5952.166696662465;5957.761689532414;5966.791162309325;5856.326522449919;5864.0324346482885;5935.020721580934;5935.723819378833;5936.792212272571;4396.450443694538;4525.275955847065;4593.609543188833;4643.651726120537;4671.369365135697;4624.3294722265255;4675.50907154749;4681.485036645966;4690.765461726917;4696.9530304696855;4655.580997710205;4656.5110663380365;4660.277656963176;4670.252759558472;4677.181493238687;4405.515393306734;4540.523245059271;4638.652101092432;4651.093036857814;4665.790039448233;4140.254754144253;4149.730267532601;4152.252594532983;4160.251154792136;4160.771157586331;5719.885602287973;5723.284589426322;5725.055365864628;5729.88540229193;5736.2542869427125;5464.398916119224;5476.3702174250075;5478.424765399615;5516.668999860021;5524.756929690828;6332.778352757678;6337.778177763802;6348.17473728417;6357.713902874336;6364.745410183587;4376.365427013097;4524.751138687371;4526.366308716782;4536.909261814778;4625.722456652612;6516.446102081329;6567.310432404624;6641.535092543524;6646.468282537386;6679.799606011828;4605.608523275492;4609.815607375667;4613.723176609415;4623.838165664186;4629.444466663955;4676.69601475903;4680.648951328664;4682.672212945129;4684.601808846218;4688.132695451352;5355.544778693855;5369.986255154317;5372.167314066326;5383.246345511631;5388.245645609618;6263.498920086382;6385.531327794633;6397.712102955378;6400.295967443578;6413.743450262031;1635.0680112336092;1648.3489021836308;1656.1057029204094;1658.336665333876;1658.6268089679725;1035.9533820978074;1093.1528065749108;1096;1103.1836441033738;1120.232640641147;6052.152698622196;6067.089936509559;6068.150458935753;6077.787277445268;6126.969365153146;6524.380183882524;6527.379898909596;6536.607803531803;6605.603663780189;6609.339066093352;6110.725017374229;6118.174046503754;6120.265568131853;6129.632222066691;6138.815835524942;3490.808005559668;3526.9647303526635;3529.205928666081;3529.8235088245483;3536.6463353664944;6607.768728094494;6716.496262780311;6773.491988100814;6782.898256526156;6788.694508747119;6724.596524208563;6755.560888542229;6830.043793868862;6833.077534532874;6841.076454678654;6846.760363387258;6863.073485079551;6870.3473170048765;6872.072270243553;6876;6656.134702488645;6662.566933149524;6669.333066693292;6669.933300666931;6674.299198584079;6299;6413.134226879498;6471.935280647322;6571.244306904576;6574.769883054261;6679.332066793282;6736.831579210559;6739.5619284746335;6852.28051054652;6858.142732158481;4623.791929363119;4657.604103651092;4663.137319595886;4666.3700400445505;4671.761983074556;6640.203175618956;6650.767223147167;6652.201735791542;6660.167479065117;6672.399484046459;6371.681415929278;6387.297397286387;6429.32492088324;6476.125723027331;6480.837979050561;6407.647579383179;6429.164208652845;6449.193850768654;6464.2889282177985;6464.676766161767;6327.683615819283;6333.334999825136;6336.334684858023;6348.71430785625;6352.745890164341;6491.513136514686;6494.350564943468;6498;6504.447121994684;6511.38141876521;6022.789202377896;6175.5677102602385;6227.844303892439;6327.11420401135;6346.428821406095 11:45:32 INFO - PROCESS | 26314 | |5;yui.html;771.1209221487504;791.1495142721574;859.286791962671;897.1566727276355;914.3416739947236;14900.478483253088;15043.623909402271;15047.849521504782;15075.773863392043;15129.773053404195;13968.930155349235;14645.04807187532;14693.118412895206;14703.264836758173;14709.92645036776;776.5496012312873;937.5640327247828;945.7635591102242;958.7651025498727;970.1268858027761;962.672691284963;977.0571398600349;977.662706366306;979.6081567373036;982.6069572171153;995.2983146881468;998.5556427389814;1002.4386343647544;1002.468691593453;1002.7944271424341;804.264098350012;1000.3847633705255;1037.102905986324;1042.4110377636612;1043.191526566913;727.1710250314645;727.654364177017;730.9159446663649;733.4828945593343;734.8493558820429;14920.62698432537;14978.176200308979;14985.850141498555;14987.100773953598;14999.400023999027;13202.33988300581;13261.668458288523;13287.468501259938;13839.238841863693;13906.51327203543;11637.35994520301;11698.181127321091;11711.297322160697;11979.520819167223;12057.577984770578;3925.450436938831;3960.2871483133026;3961.504811898513;3981.30327192743;4005.5794141615293;49689.25466118011;50791.492085079415;50793;51239;51322.48677513214;11516;11720.88279117215;11892.702682433008;11924.10569207313;12194.207376520499;20403.693944590843;20425;20454.795452045586;20456.284030058876;20457.386278411373;8370.790730231793;8477.872831907527;8564.443311184754;8615.396922215385;8661.30709543235;4605.171069207575;4613.1004454131125;4696.084263568571;4728.31439441286;4786.880327991828;3551.271989242199;3570.7500474967023;3572.464130380412;3582.3193593217206;3584.8386822593047;611.5382885921101;661.5402295404743;665.3213722003626;665.653859992801;677.5799004617169;593.0748033068427;659.2912618934664;662.536224642752;726.920038795732;751.2224847283036;8422.747317580483;8548.658053677784;8679.91320086791;8809.471431714117;8814.515201663842;644.8452371430917;752.7967448788905;758.2796343473722;763.6983391560302;765.5062484697339;4080.591940805896;4150.709450338508;4162;4175.478065241845;4190.161967606491;58852.70573647104;59977;60331.396686033455;60512.394876051556;60676;52039.21941170885;52204.47795522072;53644.463555364724;53668.463315367124;54852.45147548553;47854.760726196146;48520.27219591709;51759.74120129375;53332;59137.40862591405;8745.387822852339;9076.909230907871;9161.954190229273;9286;9437.858432123387;35947.1013224661;36470.27059458849;36650.45024324691;37152.628473715995;37255.627443725214;42466.5753342475;43626;46345;46633.06733865372;46685.299720504896;12480.687982800502;12540;12654.255292818978;12681.8097728536;12998.935005324913;12480.875191248335;12951.611451656465;13079.673008174872;13422.463101475832;13664.043516953718;11799.705007374885;12004.939975300067;12112.273263604213;12263;12441.875581244434;12406.255624662188;12452.128351015343;12520.812187817008;12527.498900043896;12831.42258598384;11122.944385278022;11508.13688973347;11627.186096973131;11688.240264382788;11848.940755296167;10699.411532365795;10810;10890.564377424815;10932.234743568191;11324.37715925632;10031;10245;10250.692479225636;10264.127549158107;10353.896461035294 11:45:32 INFO - PROCESS | 26314 | __end_tp_report 11:45:32 INFO - PROCESS | 26314 | __start_cc_report 11:45:32 INFO - PROCESS | 26314 | _x_x_mozilla_cycle_collect,795 11:45:32 INFO - PROCESS | 26314 | __end_cc_report 11:45:32 INFO - PROCESS | 26314 | __startTimestamp1463510732887__endTimestamp 11:45:32 INFO - PROCESS | 26314 | 11:45:32 INFO - PROCESS | 26314 | ------- Summary: start ------- 11:45:32 INFO - PROCESS | 26314 | Number of tests: 6 11:45:32 INFO - PROCESS | 26314 | 11:45:32 INFO - PROCESS | 26314 | [#0] dojo.html Cycles:165 Average:5376.08 Median:5575.72 stddev:593.79 (10.6%) stddev-sans-first:571.93 11:45:32 INFO - PROCESS | 26314 | Values: 3259.7 3360.7 3370.7 3378.7 3405.4 5358.7 5377.8 5382.7 5398.5 5411.4 5359.5 5378.4 5401.7 5402.9 5411.7 4747.5 4906.2 4909.1 4951.9 4999.6 4834.5 4907.1 4936.6 4937.9 4967.3 4829.0 4917.5 4933.8 4940.5 4954.9 4938.4 4991.3 4995.6 5006.9 5011.8 4758.4 4848.2 4902.2 4930.2 4942.0 5167.4 5170.1 5184.1 5185.0 5210.9 5744.2 5746.2 5757.9 5760.7 5788.1 5667.4 5676.5 5736.6 5787.4 5811.4 5427.3 5428.6 5430.2 5431.1 5431.8 5756.8 5859.4 5912.8 5917.1 5920.9 5741.7 5797.0 5805.0 5824.3 5841.4 5799.6 5802.2 5802.5 5804.5 5807.2 5546.8 5747.8 5750.4 5762.9 5766.9 5776.6 5784.7 5789.1 5794.9 5828.4 4351.2 4363.8 4378.1 4380.4 4405.0 3804.2 3909.1 3961.6 3970.0 3978.4 5575.7 5579.2 5593.2 5600.2 5605.2 5877.6 5912.3 5912.6 5913.7 5915.0 5357.2 5380.5 5472.3 5475.8 5568.1 4950.8 4997.6 4998.6 4999.8 5028.7 5960.8 5994.4 6033.1 6038.6 6039.4 5673.0 5744.3 5800.1 5801.2 5810.7 6013.5 6016.6 6028.8 6031.8 6036.5 5543.8 5728.5 5730.9 5731.5 5731.6 5789.0 5839.9 5849.2 5853.7 5873.2 5648.0 5657.6 5676.8 5681.4 5686.7 5547.1 5619.3 5671.2 5673.0 5674.1 5470.1 5504.3 5518.8 5524.9 5544.4 5607.8 5630.6 5642.4 5644.2 5646.6 5446.5 5530.0 5555.3 5562.9 5638.3 11:45:32 INFO - PROCESS | 26314 | 11:45:32 INFO - PROCESS | 26314 | [#1] ext.html Cycles:180 Average:46485.04 Median:39842.60 stddev:77268.33 (193.9%) stddev-sans-first:77408.04 11:45:32 INFO - PROCESS | 26314 | Values: 527.2 546.2 563.7 564.8 648.1 30831.2 39826.6 39858.6 39909.0 40026.6 43223.0 43812.3 43832.6 43862.0 43875.0 8731.0 8954.6 8956.8 8965.1 8966.1 8831.4 8988.4 8990.7 8992.0 8994.1 8917.2 9253.9 9265.8 9266.8 9274.5 9094.9 9120.2 9184.4 9205.0 9205.9 8958.1 9084.9 9104.1 9106.3 9114.3 43122.1 43430.3 43574.6 43583.3 43651.3 3812.1 3922.9 4594.4 4674.1 4676.2 33078.5 33273.0 33636.7 33947.3 33999.8 4090.8 4093.9 4131.1 4187.4 4238.5 279088.0 280472.0 280540.0 280859.0 282562.0 45938.3 61074.7 62197.4 62414.4 62452.4 43796.3 44074.0 44116.3 44159.3 44175.6 15227.4 15423.4 15447.4 15449.8 15478.9 12706.9 12851.6 12858.5 12864.9 12879.4 15074.2 15110.0 15567.2 15637.7 15710.0 5795.6 5821.7 5827.3 5950.4 6065.3 898.3 987.5 995.7 1037.1 1086.2 29968.4 30166.4 30177.4 30406.0 30483.4 1034.2 1087.1 1158.3 1167.5 1214.2 13919.4 13935.2 14022.4 14365.9 14408.6 346556.0 357728.0 359595.0 359814.0 360589.0 56316.6 57197.4 57307.7 57584.4 57637.0 1322.4 1411.6 1453.7 1462.5 1478.7 28057.2 29358.0 29380.4 30171.7 30275.4 45052.5 45270.5 45449.0 45524.5 45580.3 235033.0 235169.0 235271.0 236472.0 237476.0 30249.7 34851.5 35048.5 35120.0 35211.6 39872.6 40422.4 40471.2 41491.2 41706.8 36677.3 37284.0 37329.6 37363.8 37651.8 36117.3 41948.4 44354.8 44429.6 45317.3 38884.6 39673.0 39733.4 39734.8 39955.2 33311.2 33573.0 34176.1 34328.5 34510.0 25675.9 26175.7 26337.8 26370.9 26614.9 11:45:32 INFO - PROCESS | 26314 | 11:45:32 INFO - PROCESS | 26314 | [#2] jquery.html Cycles:180 Average:27060.90 Median:2392.26 stddev:79728.43 (3332.8%) stddev-sans-first:79926.90 11:45:32 INFO - PROCESS | 26314 | Values: 370.8 371.2 374.9 377.4 378.5 17564.3 18208.3 19451.7 19491.2 19503.1 17858.4 17936.7 18483.8 18514.9 18519.8 5540.8 5734.9 5769.9 5771.9 5776.6 4219.4 5700.0 5998.8 6237.8 6260.2 6192.3 6197.8 6216.8 6227.1 6231.0 5896.0 6321.9 6337.5 6341.1 6342.6 3877.8 5335.9 5527.4 5548.3 5611.9 22168.7 22185.2 22272.6 22789.5 22804.9 2231.1 2338.3 2362.0 2380.7 2403.8 13813.2 13830.5 13999.5 14112.4 14167.8 1916.2 1945.0 1972.4 1980.4 2029.3 62055.7 62880.4 63197.4 63871.7 64548.4 9914.4 10270.5 10418.3 10501.6 10539.6 14687.6 14706.8 14781.9 14801.9 14804.4 8323.0 8408.5 8469.5 8525.6 8580.8 8454.6 8479.5 8488.9 8513.0 8561.7 5987.6 6129.7 6175.4 6223.4 6251.7 1792.0 1839.4 1895.6 1907.8 1935.4 926.7 1003.8 1063.3 1110.6 1162.7 17162.1 17277.7 17914.3 17951.9 18404.4 992.4 995.1 1047.5 1061.5 1138.0 10277.5 10711.0 10713.5 10749.4 10800.1 465530.0 470041.0 497479.0 503452.0 503557.0 67289.0 67693.3 69812.0 70464.6 70612.0 1076.5 1088.0 1089.3 1101.8 1102.3 16101.4 16120.0 16131.2 16230.6 16379.6 31707.4 33089.5 33932.0 34113.3 34335.3 44879.1 45269.3 46326.0 46368.5 46909.8 7806.5 8257.6 8331.4 8595.2 8785.1 7004.4 9769.7 9953.5 12198.6 12399.0 10426.5 10476.1 10554.5 10644.2 10675.7 10640.1 10703.1 10736.7 10850.1 10903.1 10168.6 10684.6 10799.5 10821.3 10827.8 8230.5 8294.5 8303.7 8471.3 8549.7 9344.9 10183.1 10418.5 10560.4 10599.7 11:45:32 INFO - PROCESS | 26314 | 11:45:32 INFO - PROCESS | 26314 | [#3] mootools.html Cycles:180 Average:5781.23 Median:3269.15 stddev:3008.17 (92.0%) stddev-sans-first:2998.85 11:45:32 INFO - PROCESS | 26314 | Values: 1432.9 1547.0 1559.5 1793.7 1927.9 7825.1 7970.0 8010.3 8024.1 8028.0 7815.9 7972.6 7977.0 7982.6 7983.3 2392.4 2414.1 2415.5 2416.2 2417.3 2424.7 2427.0 2464.2 2475.4 2477.7 2398.4 2413.3 2421.8 2427.2 2427.2 2433.6 2453.7 2465.2 2466.2 2472.6 2396.6 2455.3 2466.7 2467.0 2477.5 8185.6 8240.8 8251.1 8251.6 8260.5 4933.4 5029.9 5052.9 5065.4 5066.4 3282.2 3298.2 3335.9 3338.4 3358.6 1116.0 1137.8 1143.8 1146.0 1154.4 11331.3 11384.1 11392.8 11400.5 11405.6 4496.4 4514.9 4561.0 4578.5 4626.8 9721.4 9724.7 9726.7 9743.9 9748.4 5153.6 5165.3 5165.8 5166.0 5170.0 3949.2 4403.0 4516.1 4517.9 4658.3 3800.3 3857.3 3863.5 3886.9 3910.5 1244.7 1261.6 1267.4 1277.7 1277.9 1435.5 1454.0 1461.5 1474.9 1503.2 7871.4 7880.6 7914.1 7925.8 7931.6 549.6 551.2 554.1 562.4 563.5 5974.8 5976.0 5988.7 6006.2 6080.2 9768.8 10127.3 10135.4 10235.7 10256.1 9768.3 9935.8 9947.7 10000.3 10090.9 7837.6 7919.2 7944.7 7986.1 8000.7 7419.1 7481.7 7608.0 7651.0 7656.5 8892.6 8952.1 9023.1 9144.3 9194.6 9046.1 9147.3 9147.5 9183.5 9373.7 6369.8 6512.1 6517.1 7383.3 7459.2 7731.5 8012.6 8035.2 8037.6 8043.4 7087.0 7239.6 7281.2 7295.2 7367.4 7157.5 7192.8 7256.1 7278.6 7323.0 7434.2 7461.0 7494.4 7495.9 7496.6 6766.1 6830.1 6831.7 6832.4 6849.9 6643.9 6997.3 7005.0 7015.3 7017.5 11:45:32 INFO - PROCESS | 26314 | 11:45:32 INFO - PROCESS | 26314 | [#4] prototype.html Cycles:180 Average:5365.77 Median:6037.47 stddev:1596.91 (26.4%) stddev-sans-first:1556.54 11:45:32 INFO - PROCESS | 26314 | Values: 358.5 365.8 366.3 366.4 369.9 5922.6 5938.8 5952.2 5957.8 5966.8 5856.3 5864.0 5935.0 5935.7 5936.8 4396.5 4525.3 4593.6 4643.7 4671.4 4624.3 4675.5 4681.5 4690.8 4697.0 4655.6 4656.5 4660.3 4670.3 4677.2 4405.5 4540.5 4638.7 4651.1 4665.8 4140.3 4149.7 4152.3 4160.3 4160.8 5719.9 5723.3 5725.1 5729.9 5736.3 5464.4 5476.4 5478.4 5516.7 5524.8 6332.8 6337.8 6348.2 6357.7 6364.7 4376.4 4524.8 4526.4 4536.9 4625.7 6516.4 6567.3 6641.5 6646.5 6679.8 4605.6 4609.8 4613.7 4623.8 4629.4 4676.7 4680.6 4682.7 4684.6 4688.1 5355.5 5370.0 5372.2 5383.2 5388.2 6263.5 6385.5 6397.7 6400.3 6413.7 1635.1 1648.3 1656.1 1658.3 1658.6 1036.0 1093.2 1096.0 1103.2 1120.2 6052.2 6067.1 6068.2 6077.8 6127.0 6524.4 6527.4 6536.6 6605.6 6609.3 6110.7 6118.2 6120.3 6129.6 6138.8 3490.8 3527.0 3529.2 3529.8 3536.6 6607.8 6716.5 6773.5 6782.9 6788.7 6724.6 6755.6 6830.0 6833.1 6841.1 6846.8 6863.1 6870.3 6872.1 6876.0 6656.1 6662.6 6669.3 6669.9 6674.3 6299.0 6413.1 6471.9 6571.2 6574.8 6679.3 6736.8 6739.6 6852.3 6858.1 4623.8 4657.6 4663.1 4666.4 4671.8 6640.2 6650.8 6652.2 6660.2 6672.4 6371.7 6387.3 6429.3 6476.1 6480.8 6407.6 6429.2 6449.2 6464.3 6464.7 6327.7 6333.3 6336.3 6348.7 6352.7 6491.5 6494.4 6498.0 6504.4 6511.4 6022.8 6175.6 6227.8 6327.1 6346.4 11:45:32 INFO - PROCESS | 26314 | 11:45:32 INFO - PROCESS | 26314 | [#5] yui.html Cycles:180 Average:14824.21 Median:3993.44 stddev:16779.76 (420.2%) stddev-sans-first:16793.64 11:45:32 INFO - PROCESS | 26314 | Values: 771.1 791.1 859.3 897.2 914.3 14900.5 15043.6 15047.8 15075.8 15129.8 13968.9 14645.0 14693.1 14703.3 14709.9 776.5 937.6 945.8 958.8 970.1 962.7 977.1 977.7 979.6 982.6 995.3 998.6 1002.4 1002.5 1002.8 804.3 1000.4 1037.1 1042.4 1043.2 727.2 727.7 730.9 733.5 734.8 14920.6 14978.2 14985.9 14987.1 14999.4 13202.3 13261.7 13287.5 13839.2 13906.5 11637.4 11698.2 11711.3 11979.5 12057.6 3925.5 3960.3 3961.5 3981.3 4005.6 49689.3 50791.5 50793.0 51239.0 51322.5 11516.0 11720.9 11892.7 11924.1 12194.2 20403.7 20425.0 20454.8 20456.3 20457.4 8370.8 8477.9 8564.4 8615.4 8661.3 4605.2 4613.1 4696.1 4728.3 4786.9 3551.3 3570.8 3572.5 3582.3 3584.8 611.5 661.5 665.3 665.7 677.6 593.1 659.3 662.5 726.9 751.2 8422.7 8548.7 8679.9 8809.5 8814.5 644.8 752.8 758.3 763.7 765.5 4080.6 4150.7 4162.0 4175.5 4190.2 58852.7 59977.0 60331.4 60512.4 60676.0 52039.2 52204.5 53644.5 53668.5 54852.5 47854.8 48520.3 51759.7 53332.0 59137.4 8745.4 9076.9 9162.0 9286.0 9437.9 35947.1 36470.3 36650.5 37152.6 37255.6 42466.6 43626.0 46345.0 46633.1 46685.3 12480.7 12540.0 12654.3 12681.8 12998.9 12480.9 12951.6 13079.7 13422.5 13664.0 11799.7 12004.9 12112.3 12263.0 12441.9 12406.3 12452.1 12520.8 12527.5 12831.4 11122.9 11508.1 11627.2 11688.2 11848.9 10699.4 10810.0 10890.6 10932.2 11324.4 10031.0 10245.0 10250.7 10264.1 10353.9 11:45:32 INFO - PROCESS | 26314 | -------- Summary: end -------- 11:45:32 INFO - PROCESS | 26314 | 11:45:33 INFO - TEST-INFO | 26314: exit 0 11:45:33 INFO - TEST-OK | dromaeo_css | took 1111067ms 11:45:33 INFO - TEST-START | kraken 11:45:33 INFO - operating with platform_type : linux_ 11:45:33 INFO - Initialising browser for kraken test... 11:45:33 INFO - TEST-INFO | started process 26515 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4tq_2D/profile http://localhost:43872/getInfo.html) 11:45:37 INFO - PROCESS | 26515 | __metrics Screen width/height:1600/1200 11:45:37 INFO - PROCESS | 26515 | colorDepth:24 11:45:37 INFO - PROCESS | 26515 | Browser inner width/height: 1024/697 11:45:37 INFO - PROCESS | 26515 | __metrics 11:45:38 INFO - PROCESS | 26515 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:45:39 INFO - TEST-INFO | 26515: exit 0 11:45:39 INFO - Browser initialized. 11:45:39 INFO - Running cycle 1/1 for kraken test... 11:45:39 INFO - TEST-INFO | started process 26607 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4tq_2D/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:45:51 INFO - PROCESS | 26607 | RSS: Main: 139517952 11:45:51 INFO - PROCESS | 26607 | 11:45:54 INFO - PROCESS | 26607 | Cycle 1(1): loaded http://localhost:43872/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43872/tests/kraken/driver.html?testName=audio-beat-detection) 11:45:54 INFO - PROCESS | 26607 | RSS: Main: 174551040 11:45:54 INFO - PROCESS | 26607 | 11:45:57 INFO - PROCESS | 26607 | Cycle 1(1): loaded http://localhost:43872/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43872/tests/kraken/driver.html?testName=audio-dft) 11:45:57 INFO - PROCESS | 26607 | RSS: Main: 173228032 11:45:57 INFO - PROCESS | 26607 | 11:46:00 INFO - PROCESS | 26607 | Cycle 1(1): loaded http://localhost:43872/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43872/tests/kraken/driver.html?testName=audio-fft) 11:46:01 INFO - PROCESS | 26607 | RSS: Main: 168415232 11:46:01 INFO - PROCESS | 26607 | 11:46:03 INFO - PROCESS | 26607 | Cycle 1(1): loaded http://localhost:43872/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43872/tests/kraken/driver.html?testName=audio-oscillator) 11:46:03 INFO - PROCESS | 26607 | RSS: Main: 169025536 11:46:03 INFO - PROCESS | 26607 | 11:46:06 INFO - PROCESS | 26607 | Cycle 1(1): loaded http://localhost:43872/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43872/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:46:06 INFO - PROCESS | 26607 | RSS: Main: 167362560 11:46:06 INFO - PROCESS | 26607 | 11:46:09 INFO - PROCESS | 26607 | Cycle 1(1): loaded http://localhost:43872/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43872/tests/kraken/driver.html?testName=imaging-darkroom) 11:46:10 INFO - PROCESS | 26607 | RSS: Main: 167493632 11:46:10 INFO - PROCESS | 26607 | 11:46:13 INFO - PROCESS | 26607 | Cycle 1(1): loaded http://localhost:43872/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43872/tests/kraken/driver.html?testName=imaging-desaturate) 11:46:14 INFO - PROCESS | 26607 | RSS: Main: 168402944 11:46:14 INFO - PROCESS | 26607 | 11:46:16 INFO - PROCESS | 26607 | Cycle 1(1): loaded http://localhost:43872/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43872/tests/kraken/driver.html?testName=json-parse-financial) 11:46:17 INFO - PROCESS | 26607 | RSS: Main: 168521728 11:46:17 INFO - PROCESS | 26607 | 11:46:19 INFO - PROCESS | 26607 | Cycle 1(1): loaded http://localhost:43872/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43872/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:46:19 INFO - PROCESS | 26607 | RSS: Main: 175239168 11:46:19 INFO - PROCESS | 26607 | 11:46:21 INFO - PROCESS | 26607 | Cycle 1(1): loaded http://localhost:43872/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43872/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:46:22 INFO - PROCESS | 26607 | RSS: Main: 173412352 11:46:22 INFO - PROCESS | 26607 | 11:46:23 INFO - PROCESS | 26607 | Cycle 1(1): loaded http://localhost:43872/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43872/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:46:24 INFO - PROCESS | 26607 | RSS: Main: 179683328 11:46:24 INFO - PROCESS | 26607 | 11:46:26 INFO - PROCESS | 26607 | Cycle 1(1): loaded http://localhost:43872/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43872/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:46:27 INFO - PROCESS | 26607 | RSS: Main: 183828480 11:46:27 INFO - PROCESS | 26607 | 11:46:30 INFO - PROCESS | 26607 | Cycle 1(1): loaded http://localhost:43872/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43872/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:46:30 INFO - PROCESS | 26607 | RSS: Main: 182546432 11:46:30 INFO - PROCESS | 26607 | 11:46:32 INFO - PROCESS | 26607 | Cycle 1(1): loaded http://localhost:43872/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43872/tests/kraken/driver.html?testName=ai-astar) 11:46:32 INFO - PROCESS | 26607 | RSS: Main: 244584448 11:46:32 INFO - PROCESS | 26607 | 11:46:32 INFO - PROCESS | 26607 | __start_tp_report 11:46:32 INFO - PROCESS | 26607 | _x_x_mozilla_page_load 11:46:32 INFO - PROCESS | 26607 | _x_x_mozilla_page_load_details 11:46:32 INFO - PROCESS | 26607 | |i|pagename|runs| 11:46:32 INFO - PROCESS | 26607 | |0;ai-astar;113;112;106;109;111;111;100;119;111;110 11:46:32 INFO - PROCESS | 26607 | |1;audio-beat-detection;166;127;152;171;133;154;150;126;173;130 11:46:32 INFO - PROCESS | 26607 | |2;audio-dft;161;162;161;161;161;160;159;162;161;161 11:46:32 INFO - PROCESS | 26607 | |3;audio-fft;74;76;77;162;76;77;76;77;161;76 11:46:32 INFO - PROCESS | 26607 | |4;audio-oscillator;93;93;147;94;93;93;152;94;93;142 11:46:32 INFO - PROCESS | 26607 | |5;imaging-gaussian-blur;116;116;117;116;117;116;117;116;116;117 11:46:32 INFO - PROCESS | 26607 | |6;imaging-darkroom;146;145;145;145;146;145;145;145;145;146 11:46:32 INFO - PROCESS | 26607 | |7;imaging-desaturate;95;95;95;96;95;96;95;97;96;95 11:46:32 INFO - PROCESS | 26607 | |8;json-parse-financial;57;56;58;56;56;56;56;56;63;55 11:46:32 INFO - PROCESS | 26607 | |9;json-stringify-tinderbox;64;65;65;64;64;65;65;65;65;66 11:46:32 INFO - PROCESS | 26607 | |10;stanford-crypto-aes;78;79;79;77;78;78;85;79;78;83 11:46:32 INFO - PROCESS | 26607 | |11;stanford-crypto-ccm;113;120;112;114;114;123;115;113;114;116 11:46:32 INFO - PROCESS | 26607 | |12;stanford-crypto-pbkdf2;140;139;151;151;148;138;144;144;144;147 11:46:32 INFO - PROCESS | 26607 | |13;stanford-crypto-sha256-iterative;66;70;67;67;69;65;67;64;65;69 11:46:32 INFO - PROCESS | 26607 | __end_tp_report 11:46:32 INFO - PROCESS | 26607 | __start_cc_report 11:46:32 INFO - PROCESS | 26607 | _x_x_mozilla_cycle_collect,1055 11:46:32 INFO - PROCESS | 26607 | __end_cc_report 11:46:32 INFO - PROCESS | 26607 | __startTimestamp1463510792591__endTimestamp 11:46:32 INFO - PROCESS | 26607 | 11:46:32 INFO - PROCESS | 26607 | ------- Summary: start ------- 11:46:32 INFO - PROCESS | 26607 | Number of tests: 14 11:46:32 INFO - PROCESS | 26607 | 11:46:32 INFO - PROCESS | 26607 | [#0] ai-astar Cycles:10 Average:110.20 Median:111.00 stddev:4.87 (4.4%) stddev-sans-first:5.06 11:46:32 INFO - PROCESS | 26607 | Values: 113.0 112.0 106.0 109.0 111.0 111.0 100.0 119.0 111.0 110.0 11:46:32 INFO - PROCESS | 26607 | 11:46:32 INFO - PROCESS | 26607 | [#1] audio-beat-detection Cycles:10 Average:148.20 Median:153.00 stddev:18.28 (11.9%) stddev-sans-first:18.22 11:46:32 INFO - PROCESS | 26607 | Values: 166.0 127.0 152.0 171.0 133.0 154.0 150.0 126.0 173.0 130.0 11:46:32 INFO - PROCESS | 26607 | 11:46:32 INFO - PROCESS | 26607 | [#2] audio-dft Cycles:10 Average:160.90 Median:161.00 stddev:0.88 (0.5%) stddev-sans-first:0.93 11:46:32 INFO - PROCESS | 26607 | Values: 161.0 162.0 161.0 161.0 161.0 160.0 159.0 162.0 161.0 161.0 11:46:32 INFO - PROCESS | 26607 | 11:46:32 INFO - PROCESS | 26607 | [#3] audio-fft Cycles:10 Average:93.20 Median:76.00 stddev:36.01 (47.4%) stddev-sans-first:37.52 11:46:32 INFO - PROCESS | 26607 | Values: 74.0 76.0 77.0 162.0 76.0 77.0 76.0 77.0 161.0 76.0 11:46:32 INFO - PROCESS | 26607 | 11:46:32 INFO - PROCESS | 26607 | [#4] audio-oscillator Cycles:10 Average:109.40 Median:93.00 stddev:26.06 (28.0%) stddev-sans-first:26.95 11:46:32 INFO - PROCESS | 26607 | Values: 93.0 93.0 147.0 94.0 93.0 93.0 152.0 94.0 93.0 142.0 11:46:32 INFO - PROCESS | 26607 | 11:46:32 INFO - PROCESS | 26607 | [#5] imaging-gaussian-blur Cycles:10 Average:116.40 Median:116.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 11:46:32 INFO - PROCESS | 26607 | Values: 116.0 116.0 117.0 116.0 117.0 116.0 117.0 116.0 116.0 117.0 11:46:32 INFO - PROCESS | 26607 | 11:46:32 INFO - PROCESS | 26607 | [#6] imaging-darkroom Cycles:10 Average:145.30 Median:145.00 stddev:0.48 (0.3%) stddev-sans-first:0.44 11:46:32 INFO - PROCESS | 26607 | Values: 146.0 145.0 145.0 145.0 146.0 145.0 145.0 145.0 145.0 146.0 11:46:32 INFO - PROCESS | 26607 | 11:46:32 INFO - PROCESS | 26607 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:95.50 stddev:0.71 (0.7%) stddev-sans-first:0.73 11:46:32 INFO - PROCESS | 26607 | Values: 95.0 95.0 95.0 96.0 95.0 96.0 95.0 97.0 96.0 95.0 11:46:32 INFO - PROCESS | 26607 | 11:46:32 INFO - PROCESS | 26607 | [#8] json-parse-financial Cycles:10 Average:56.90 Median:56.00 stddev:2.28 (4.1%) stddev-sans-first:2.42 11:46:32 INFO - PROCESS | 26607 | Values: 57.0 56.0 58.0 56.0 56.0 56.0 56.0 56.0 63.0 55.0 11:46:32 INFO - PROCESS | 26607 | 11:46:32 INFO - PROCESS | 26607 | [#9] json-stringify-tinderbox Cycles:10 Average:64.80 Median:65.00 stddev:0.63 (1.0%) stddev-sans-first:0.60 11:46:32 INFO - PROCESS | 26607 | Values: 64.0 65.0 65.0 64.0 64.0 65.0 65.0 65.0 65.0 66.0 11:46:32 INFO - PROCESS | 26607 | 11:46:32 INFO - PROCESS | 26607 | [#10] stanford-crypto-aes Cycles:10 Average:79.40 Median:79.00 stddev:2.55 (3.2%) stddev-sans-first:2.65 11:46:32 INFO - PROCESS | 26607 | Values: 78.0 79.0 79.0 77.0 78.0 78.0 85.0 79.0 78.0 83.0 11:46:32 INFO - PROCESS | 26607 | 11:46:32 INFO - PROCESS | 26607 | [#11] stanford-crypto-ccm Cycles:10 Average:115.40 Median:114.50 stddev:3.47 (3.0%) stddev-sans-first:3.57 11:46:32 INFO - PROCESS | 26607 | Values: 113.0 120.0 112.0 114.0 114.0 123.0 115.0 113.0 114.0 116.0 11:46:32 INFO - PROCESS | 26607 | 11:46:32 INFO - PROCESS | 26607 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:144.60 Median:145.50 stddev:4.67 (3.2%) stddev-sans-first:4.65 11:46:32 INFO - PROCESS | 26607 | Values: 140.0 139.0 151.0 151.0 148.0 138.0 144.0 144.0 144.0 147.0 11:46:32 INFO - PROCESS | 26607 | 11:46:32 INFO - PROCESS | 26607 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.90 Median:67.00 stddev:1.97 (2.9%) stddev-sans-first:2.06 11:46:32 INFO - PROCESS | 26607 | Values: 66.0 70.0 67.0 67.0 69.0 65.0 67.0 64.0 65.0 69.0 11:46:32 INFO - PROCESS | 26607 | -------- Summary: end -------- 11:46:32 INFO - PROCESS | 26607 | 11:46:33 INFO - TEST-INFO | 26607: exit 0 11:46:33 INFO - TEST-OK | kraken | took 60034ms 11:46:33 INFO - SUITE-END | took 1171s 11:46:33 INFO - Completed test suite (00:19:31) 11:46:33 INFO - javascript benchmark 11:46:33 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3259.690329418705, 3360.714339281161, 3370.6629337066297, 3378.695917367438, 3405.4381027130516, 5358.705271210087, 5377.8117765878205, 5382.730863456826, 5398.541124004454, 5411.404745477994, 5359.517643412092, 5378.381486129097, 5401.729913504319, 5402.945970540293, 5411.675299482034, 4747.501512341206, 4906.19047857104, 4909.067277217335, 4951.900961980758, 4999.60003199745, 4834.540718631724, 4907.067657145149, 4936.58039066678, 4937.901241975158, 4967.329410529586, 4828.97585512072, 4917.532834380728, 4933.827316043939, 4940.529735132433, 4954.925676114861, 4938.3580134582635, 4991.32617096691, 4995.625328100389, 5006.949930500685, 5011.774470148834, 4758.405199350082, 4848.248521479177, 4902.2156454967035, 4930.186519224324, 4941.950580494185, 5167.431582525919, 5170.121079416508, 5184.144616138333, 5185.040767458032, 5210.895782084375, 5744.224529688522, 5746.224259724925, 5757.913631295534, 5760.654360738369, 5788.131780232957, 5667.4049224831215, 5676.460736230093, 5736.627119237236, 5787.421257874179, 5811.418858114154, 5427.267318911936, 5428.5928555358505, 5430.15832545956, 5431.076716958087, 5431.83704488866, 5756.769729210869, 5859.414058594107, 5912.76348946046, 5917.142014407973, 5920.940790592125, 5741.684207368635, 5797.0, 5804.970975145097, 5824.271966004249, 5841.41585841421, 5799.594028418054, 5802.245708057925, 5802.47777700009, 5804.477597016289, 5807.245058142415, 5546.77812887488, 5747.770089196385, 5750.4249575042995, 5762.94237057624, 5766.913496297559, 5776.595638305278, 5784.652920824764, 5789.102689083199, 5794.913076303858, 5828.388019257917, 4351.19502891966, 4363.781810909441, 4378.0806030733265, 4380.364847097153, 4405.03089320349, 3804.239152169577, 3909.0618251619408, 3961.58403367648, 3969.980150099231, 3978.4430179774854, 5575.721213939287, 5579.246801681802, 5593.216949627055, 5600.187972743929, 5605.243292155588, 5877.5591830612875, 5912.290525137011, 5912.645241285537, 5913.674747888907, 5915.024021036566, 5357.223202635596, 5380.542653874386, 5472.288602481652, 5475.753591088411, 5568.081266590967, 4950.801967921243, 4997.550220480101, 4998.550130488274, 4999.825006124768, 5028.698278103326, 5960.76156953717, 5994.430529099728, 6033.095035744674, 6038.607490513103, 6039.396060393926, 5673.0, 5744.281964754406, 5800.1299805029585, 5801.1878337032, 5810.738516766671, 6013.458788709037, 6016.578839481194, 6028.758849645965, 6031.849203769941, 6036.456718895321, 5543.77824887, 5728.455796699307, 5730.942690573208, 5731.484166425042, 5731.627444216113, 5788.971055144866, 5839.912401314069, 5849.181114643869, 5853.736581853912, 5873.207117039145, 5647.971760141338, 5657.632253903483, 5676.829695109153, 5681.403452637579, 5686.715664216856, 5547.0570003098765, 5619.297587801525, 5671.206031155559, 5673.0, 5674.06377947634, 5470.070088085115, 5504.311961004874, 5518.834434966958, 5524.861878453071, 5544.445555444423, 5607.80372686954, 5630.60585758993, 5642.351129620146, 5644.209810626434, 5646.576506762091, 5446.455354464521, 5530.032244357302, 5555.30558680165, 5562.91655625174, 5638.295213098363], "unit": "score", "name": "dojo.html", "value": 5338.269734449419}, {"lowerIsBetter": false, "replicates": [527.2486706443318, 546.2243614068026, 563.6702529020522, 564.7938502446606, 648.1185587600864, 30831.229219269528, 39826.60173398265, 39858.60141398585, 39909.0, 40026.599734002615, 43223.0, 43812.3428148578, 43832.56167438324, 43862.0, 43875.0, 8730.952285725705, 8954.552272386387, 8956.776080597972, 8965.103489651015, 8966.0585638508, 8831.425957312786, 8988.415752976036, 8990.68532601359, 8991.95504022479, 8994.10058994102, 8917.152870477294, 9253.907460925406, 9265.814683706321, 9266.768330791716, 9274.48990305533, 9094.86357704635, 9120.17918387345, 9184.448933064004, 9204.95397523008, 9205.907940920606, 8958.104189581056, 9084.8637270441, 9104.13510716481, 9106.27149828012, 9114.270858331383, 43122.13755724899, 43430.348544771856, 43574.56425435768, 43583.34624980628, 43651.34522982158, 3812.1041555234497, 3922.882313530599, 4594.402727645384, 4674.065186962621, 4676.158291507527, 33078.50382244268, 33273.0, 33636.6636333636, 33947.321053579035, 33999.83000085009, 4090.8159132839096, 4093.8771836844644, 4131.084596217067, 4187.371894215861, 4238.491381034265, 279088.0, 280472.0, 280540.0, 280858.99999999796, 282562.0, 45938.31092533615, 61074.69462652658, 62197.37802621916, 62414.375856241764, 62452.375476245565, 43796.3430548542, 44074.0, 44116.3382549262, 44159.33760993523, 44175.558244417145, 15227.390904363923, 15423.383064677288, 15447.38210471591, 15449.84550154484, 15478.922605387126, 12706.872931270755, 12851.550195743292, 12858.549950751678, 12864.935675321563, 12879.42042608085, 15074.170920599254, 15110.0, 15567.221638918008, 15637.68724625501, 15710.0, 5795.594308398456, 5821.7380217890295, 5827.329857066492, 5950.4049595041015, 6065.272167339947, 898.3172788680519, 987.53585814667, 995.6963126246565, 1037.1495373793568, 1086.21792309537, 29968.40063198724, 30166.396672066436, 30177.396452070836, 30406.0, 30483.39033219323, 1034.2398337222135, 1087.1465899269035, 1158.3108050709814, 1167.4629670351733, 1214.1622280626339, 13919.373628186553, 13935.163890166623, 14022.368993395321, 14365.92817035929, 14408.567742967727, 346556.0, 357728.0, 359595.0, 359814.0, 360589.0, 56316.59208519738, 57197.428025720044, 57307.71346143326, 57584.424155758745, 57637.0, 1322.3652646729624, 1411.6470882279225, 1453.738327101132, 1462.5466105507326, 1478.719043381754, 28057.158285251477, 29358.0, 29380.41239175162, 30171.698283017766, 30275.394492110474, 45052.549474506144, 45270.54729452663, 45449.0, 45524.54475455203, 45580.31629525493, 235033.0, 235169.0, 235271.0, 236472.0, 237476.0, 30249.697503025567, 34851.4772278411, 35048.47427288542, 35120.0, 35211.64788352186, 39872.601273988046, 40422.39366409565, 40471.19057618772, 41491.170176596905, 41706.79146604247, 36677.26645467022, 37284.0, 37329.62670373262, 37363.813180933925, 37651.81174094112, 36117.27765444729, 41948.37077443902, 44354.77822610866, 44429.555704442544, 45317.32024019576, 38884.61115388923, 39673.0, 39733.403998940616, 39734.80132599318, 39955.200895982496, 33311.167220819676, 33573.0, 34176.14559636029, 34328.48507272343, 34510.0, 25675.871620641778, 26175.738242618092, 26337.809737050546, 26370.868145659148, 26614.866925665247], "unit": "score", "name": "ext.html", "value": 18762.20477320046}, {"lowerIsBetter": false, "replicates": [370.84053856841564, 371.20747204717935, 374.9043993781586, 377.3566069850904, 378.47203151603514, 17564.297428102876, 18208.271669133235, 19451.708224376645, 19491.220351185937, 19503.12235949382, 17858.374956876512, 17936.730949035777, 18483.81516184838, 18514.907425462887, 18519.81480185198, 5540.833774986747, 5734.913976290359, 5769.942300576982, 5771.913421298684, 5776.59563830532, 4219.43037689911, 5699.971500142494, 5998.7600495980105, 6237.750489980395, 6260.248770147566, 6192.318844927055, 6197.783077592285, 6216.782412615559, 6227.065940108997, 6231.0, 5896.0, 6321.936780632181, 6337.524685648572, 6341.143945567335, 6342.619442833398, 3877.7673339599714, 5335.946640533583, 5527.419620939824, 5548.306461692288, 5611.9438805612235, 22168.667469987962, 22185.223517176822, 22272.554548909095, 22789.544209115724, 22804.885975570018, 2231.129859354853, 2338.3101984914492, 2361.9645705314433, 2380.7143142822974, 2403.8076953843824, 13813.240271785047, 13830.515931942333, 13999.480612876801, 14112.364943577564, 14167.78748318776, 1916.2430839818194, 1944.9708254376196, 1972.3885595465308, 1980.386080315107, 2029.3201777404588, 62055.68972155156, 62880.37119628791, 63197.36802631961, 63871.722565548895, 64548.3545164547, 9914.40513569188, 10270.486475676187, 10418.270721049605, 10501.632442864464, 10539.63111291101, 14687.55937321882, 14706.779398309034, 14781.852181478047, 14801.925990369979, 14804.407823686932, 8323.0, 8408.537530435762, 8469.5341756204, 8525.57372131391, 8580.828383432296, 8454.577271136419, 8479.48101537855, 8488.872666910001, 8512.957435212784, 8561.700340488052, 5987.6108052976415, 6129.693515324216, 6175.413335733098, 6223.408776166257, 6251.687415629201, 1792.0, 1839.3697013270883, 1895.5642000029895, 1907.7949045603518, 1935.419374187738, 926.7266156483853, 1003.8092762375126, 1063.2929102146986, 1110.5890820396505, 1162.7441962768178, 17162.056086915338, 17277.65444691099, 17914.28342866297, 17951.910240448975, 18404.35584754527, 992.3847214726916, 995.1044060345747, 1047.5286121245317, 1061.4639606998571, 1138.021301680554, 10277.486125693686, 10711.036006759428, 10713.517891694892, 10749.408782517037, 10800.135989120852, 465530.0, 470041.0, 497479.0, 503452.0, 503557.0, 67289.0, 67693.32306676969, 69812.0, 70464.64767676129, 70612.0, 1076.51556799439, 1087.9619213327496, 1089.3355053417567, 1101.7576133250673, 1102.2559772153925, 16101.355945762038, 16120.0, 16131.193440327703, 16230.594235144215, 16379.59051023734, 31707.365852683277, 33089.50365744468, 33932.0, 34113.31773364569, 34335.31329373349, 44879.10241795211, 45269.32096018628, 46326.0, 46368.536314636425, 46909.76545117253, 7806.4925779824125, 8257.587120643824, 8331.375146864131, 8595.226429621363, 8785.077566855389, 7004.3696067354185, 9769.706908792748, 9953.502324883872, 12198.634040978784, 12399.0, 10426.530806113591, 10476.109530689977, 10554.472276385997, 10644.201684873511, 10675.679729608124, 10640.095591874468, 10703.090237329603, 10736.67789966271, 10850.0777433919, 10903.127749780157, 10168.593256269667, 10684.626038088629, 10799.460026998462, 10821.296615719953, 10827.837582436427, 8230.465019773696, 8294.543800091053, 8303.6678532858, 8471.279941205066, 8549.700760473354, 9344.906550934404, 10183.083522482715, 10418.479076046016, 10560.419176945341, 10599.735006624896], "unit": "score", "name": "jquery.html", "value": 8925.025150996305}, {"lowerIsBetter": false, "replicates": [1432.856714328568, 1547.0, 1559.539935718963, 1793.6861049316374, 1927.9036048197595, 7825.139234684188, 7969.960150199248, 8010.279074883259, 8024.117347091816, 8028.036635603736, 7815.921840781604, 7972.601369931509, 7976.960115199416, 7982.560959147245, 7983.281504664579, 2392.4258178037235, 2414.0947144820693, 2415.52897185049, 2416.1905761569806, 2417.2748175547354, 2424.745401732819, 2427.0, 2464.199135281032, 2475.418276704973, 2477.665515155458, 2398.364433425144, 2413.2760171948435, 2421.7578242175728, 2427.174760581402, 2427.174760581402, 2433.634954756783, 2453.6932883389577, 2465.235776909164, 2466.235467005234, 2472.6167444046023, 2396.5566370221563, 2455.3247856839334, 2466.679331686887, 2466.9753302467107, 2477.5416547938507, 8185.631646575918, 8240.8351832963, 8251.133630968781, 8251.587420628945, 8260.545669988149, 4933.383327084114, 5029.899402011939, 5052.9242061369105, 5065.392152941634, 5066.36670416198, 3282.163048422637, 3298.224917144469, 3335.8999230022896, 3338.3990881641294, 3358.630550639452, 1115.9944200279028, 1137.8236373362142, 1143.7598104398087, 1145.9942700286529, 1154.4112502623639, 11331.263467874644, 11384.146189035773, 11392.772144557146, 11400.486978086006, 11405.600803971822, 4496.3705081288645, 4514.8938510065245, 4560.977195114003, 4578.496365399803, 4626.8149274028665, 9721.368111072758, 9724.70825875225, 9726.659566915125, 9743.853842192373, 9748.415095094317, 5153.639245252796, 5165.302684137669, 5165.767540460688, 5165.974170129125, 5170.0, 3949.229900169497, 4402.955970440319, 4516.119356725407, 4517.909641807146, 4658.277966915133, 3800.3349413853016, 3857.267119247334, 3863.459115723801, 3886.9222615547533, 3910.511186101737, 1244.6826059354808, 1261.6278197931633, 1267.4486598329756, 1277.6614197237739, 1277.8849903508542, 1435.4617018618019, 1453.985460145385, 1461.5103940180159, 1474.8820094392422, 1503.225838693074, 7871.409644276702, 7880.64537095832, 7914.089879663912, 7925.762227133196, 7931.603419828985, 549.6344930621173, 551.1539786427894, 554.1217170784352, 562.3859523168533, 563.4815969308246, 5974.820755377345, 5976.0, 5988.700564971734, 6006.159137720722, 6080.179175811298, 9768.755781105529, 10127.291089623803, 10135.391876487434, 10235.692929212135, 10256.12822910046, 9768.267379946532, 9935.801283974424, 9947.651832185838, 10000.299979001546, 10090.949545252226, 7837.568933708701, 7919.208079192034, 7944.721934732373, 7986.121526632066, 8000.719974800854, 7419.07261592301, 7481.700731970878, 7608.0489938757655, 7650.961745191238, 7656.540607563564, 8892.555372231232, 8952.14954579314, 9023.052579479323, 9144.314176436927, 9194.632214711337, 9046.140616641409, 9147.268218542367, 9147.542622868697, 9183.494907780136, 9373.718788436357, 6369.808905732835, 6512.120863683342, 6517.120188774455, 7383.2985866342615, 7459.179490256176, 7731.536107833548, 8012.599370031592, 8035.196480351918, 8037.598120094089, 8043.396745244013, 7087.0, 7239.638018099179, 7281.235470275545, 7295.197528271779, 7367.4106071515225, 7157.534760240567, 7192.820179495345, 7256.0567126273245, 7278.636068196463, 7322.96338518304, 7434.219406962191, 7461.030066091591, 7494.437917156126, 7495.887561686688, 7496.62516874165, 6766.120404347404, 6830.077939478306, 6831.69257383409, 6832.419244364086, 6849.931500684929, 6643.933560664332, 6997.265287144776, 7005.0, 7015.298470152944, 7017.543859649107], "unit": "score", "name": "mootools.html", "value": 4700.092376776835}, {"lowerIsBetter": false, "replicates": [358.50168266110103, 365.84268764431295, 366.3040223575207, 366.40459253712714, 369.9426588878725, 5922.58541902067, 5938.821835344941, 5952.166696662465, 5957.761689532414, 5966.791162309325, 5856.326522449919, 5864.0324346482885, 5935.020721580934, 5935.723819378833, 5936.792212272571, 4396.450443694538, 4525.275955847065, 4593.609543188833, 4643.651726120537, 4671.369365135697, 4624.3294722265255, 4675.50907154749, 4681.485036645966, 4690.765461726917, 4696.9530304696855, 4655.580997710205, 4656.5110663380365, 4660.277656963176, 4670.252759558472, 4677.181493238687, 4405.515393306734, 4540.523245059271, 4638.652101092432, 4651.093036857814, 4665.790039448233, 4140.254754144253, 4149.730267532601, 4152.252594532983, 4160.251154792136, 4160.771157586331, 5719.885602287973, 5723.284589426322, 5725.055365864628, 5729.88540229193, 5736.2542869427125, 5464.398916119224, 5476.3702174250075, 5478.424765399615, 5516.668999860021, 5524.756929690828, 6332.778352757678, 6337.778177763802, 6348.17473728417, 6357.713902874336, 6364.745410183587, 4376.365427013097, 4524.751138687371, 4526.366308716782, 4536.909261814778, 4625.722456652612, 6516.446102081329, 6567.310432404624, 6641.535092543524, 6646.468282537386, 6679.799606011828, 4605.608523275492, 4609.815607375667, 4613.723176609415, 4623.838165664186, 4629.444466663955, 4676.69601475903, 4680.648951328664, 4682.672212945129, 4684.601808846218, 4688.132695451352, 5355.544778693855, 5369.986255154317, 5372.167314066326, 5383.246345511631, 5388.245645609618, 6263.498920086382, 6385.531327794633, 6397.712102955378, 6400.295967443578, 6413.743450262031, 1635.0680112336092, 1648.3489021836308, 1656.1057029204094, 1658.336665333876, 1658.6268089679725, 1035.9533820978074, 1093.1528065749108, 1096.0, 1103.1836441033738, 1120.232640641147, 6052.152698622196, 6067.089936509559, 6068.150458935753, 6077.787277445268, 6126.969365153146, 6524.380183882524, 6527.379898909596, 6536.607803531803, 6605.603663780189, 6609.339066093352, 6110.725017374229, 6118.174046503754, 6120.265568131853, 6129.632222066691, 6138.815835524942, 3490.808005559668, 3526.9647303526635, 3529.205928666081, 3529.8235088245483, 3536.6463353664944, 6607.768728094494, 6716.496262780311, 6773.491988100814, 6782.898256526156, 6788.694508747119, 6724.596524208563, 6755.560888542229, 6830.043793868862, 6833.077534532874, 6841.076454678654, 6846.760363387258, 6863.073485079551, 6870.3473170048765, 6872.072270243553, 6876.0, 6656.134702488645, 6662.566933149524, 6669.333066693292, 6669.933300666931, 6674.299198584079, 6299.0, 6413.134226879498, 6471.935280647322, 6571.244306904576, 6574.769883054261, 6679.332066793282, 6736.831579210559, 6739.5619284746335, 6852.28051054652, 6858.142732158481, 4623.791929363119, 4657.604103651092, 4663.137319595886, 4666.3700400445505, 4671.761983074556, 6640.203175618956, 6650.767223147167, 6652.201735791542, 6660.167479065117, 6672.399484046459, 6371.681415929278, 6387.297397286387, 6429.32492088324, 6476.125723027331, 6480.837979050561, 6407.647579383179, 6429.164208652845, 6449.193850768654, 6464.2889282177985, 6464.676766161767, 6327.683615819283, 6333.334999825136, 6336.334684858023, 6348.71430785625, 6352.745890164341, 6491.513136514686, 6494.350564943468, 6498.0, 6504.447121994684, 6511.38141876521, 6022.789202377896, 6175.5677102602385, 6227.844303892439, 6327.11420401135, 6346.428821406095], "unit": "score", "name": "prototype.html", "value": 4854.486787415242}, {"lowerIsBetter": false, "replicates": [771.1209221487504, 791.1495142721574, 859.286791962671, 897.1566727276355, 914.3416739947236, 14900.478483253088, 15043.623909402271, 15047.849521504782, 15075.773863392043, 15129.773053404195, 13968.930155349235, 14645.04807187532, 14693.118412895206, 14703.264836758173, 14709.92645036776, 776.5496012312873, 937.5640327247828, 945.7635591102242, 958.7651025498727, 970.1268858027761, 962.672691284963, 977.0571398600349, 977.662706366306, 979.6081567373036, 982.6069572171153, 995.2983146881468, 998.5556427389814, 1002.4386343647544, 1002.468691593453, 1002.7944271424341, 804.264098350012, 1000.3847633705255, 1037.102905986324, 1042.4110377636612, 1043.191526566913, 727.1710250314645, 727.654364177017, 730.9159446663649, 733.4828945593343, 734.8493558820429, 14920.62698432537, 14978.176200308979, 14985.850141498555, 14987.100773953598, 14999.400023999027, 13202.33988300581, 13261.668458288523, 13287.468501259938, 13839.238841863693, 13906.51327203543, 11637.35994520301, 11698.181127321091, 11711.297322160697, 11979.520819167223, 12057.577984770578, 3925.450436938831, 3960.2871483133026, 3961.504811898513, 3981.30327192743, 4005.5794141615293, 49689.25466118011, 50791.492085079415, 50793.0, 51239.0, 51322.48677513214, 11516.0, 11720.88279117215, 11892.702682433008, 11924.10569207313, 12194.207376520499, 20403.693944590843, 20425.0, 20454.795452045586, 20456.284030058876, 20457.386278411373, 8370.790730231793, 8477.872831907527, 8564.443311184754, 8615.396922215385, 8661.30709543235, 4605.171069207575, 4613.1004454131125, 4696.084263568571, 4728.31439441286, 4786.880327991828, 3551.271989242199, 3570.7500474967023, 3572.464130380412, 3582.3193593217206, 3584.8386822593047, 611.5382885921101, 661.5402295404743, 665.3213722003626, 665.653859992801, 677.5799004617169, 593.0748033068427, 659.2912618934664, 662.536224642752, 726.920038795732, 751.2224847283036, 8422.747317580483, 8548.658053677784, 8679.91320086791, 8809.471431714117, 8814.515201663842, 644.8452371430917, 752.7967448788905, 758.2796343473722, 763.6983391560302, 765.5062484697339, 4080.591940805896, 4150.709450338508, 4162.0, 4175.478065241845, 4190.161967606491, 58852.70573647104, 59977.0, 60331.396686033455, 60512.394876051556, 60676.0, 52039.21941170885, 52204.47795522072, 53644.463555364724, 53668.463315367124, 54852.45147548553, 47854.760726196146, 48520.27219591709, 51759.74120129375, 53332.0, 59137.40862591405, 8745.387822852339, 9076.909230907871, 9161.954190229273, 9286.0, 9437.858432123387, 35947.1013224661, 36470.27059458849, 36650.45024324691, 37152.628473715995, 37255.627443725214, 42466.5753342475, 43626.0, 46345.0, 46633.06733865372, 46685.299720504896, 12480.687982800502, 12540.0, 12654.255292818978, 12681.8097728536, 12998.935005324913, 12480.875191248335, 12951.611451656465, 13079.673008174872, 13422.463101475832, 13664.043516953718, 11799.705007374885, 12004.939975300067, 12112.273263604213, 12263.0, 12441.875581244434, 12406.255624662188, 12452.128351015343, 12520.812187817008, 12527.498900043896, 12831.42258598384, 11122.944385278022, 11508.13688973347, 11627.186096973131, 11688.240264382788, 11848.940755296167, 10699.411532365795, 10810.0, 10890.564377424815, 10932.234743568191, 11324.37715925632, 10031.0, 10245.0, 10250.692479225636, 10264.127549158107, 10353.896461035294], "unit": "score", "name": "yui.html", "value": 6940.95371445196}], "name": "dromaeo_css", "value": 7219.379817523307}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [113.0, 112.0, 106.0, 109.0, 111.0, 111.0, 100.0, 119.0, 111.0, 110.0], "unit": "score", "name": "ai-astar", "value": 110.2}, {"lowerIsBetter": true, "replicates": [166.0, 127.0, 152.0, 171.0, 133.0, 154.0, 150.0, 126.0, 173.0, 130.0], "unit": "score", "name": "audio-beat-detection", "value": 148.2}, {"lowerIsBetter": true, "replicates": [161.0, 162.0, 161.0, 161.0, 161.0, 160.0, 159.0, 162.0, 161.0, 161.0], "unit": "score", "name": "audio-dft", "value": 160.9}, {"lowerIsBetter": true, "replicates": [74.0, 76.0, 77.0, 162.0, 76.0, 77.0, 76.0, 77.0, 161.0, 76.0], "unit": "score", "name": "audio-fft", "value": 93.2}, {"lowerIsBetter": true, "replicates": [93.0, 93.0, 147.0, 94.0, 93.0, 93.0, 152.0, 94.0, 93.0, 142.0], "unit": "score", "name": "audio-oscillator", "value": 109.4}, {"lowerIsBetter": true, "replicates": [116.0, 116.0, 117.0, 116.0, 117.0, 116.0, 117.0, 116.0, 116.0, 117.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 116.4}, {"lowerIsBetter": true, "replicates": [146.0, 145.0, 145.0, 145.0, 146.0, 145.0, 145.0, 145.0, 145.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 145.3}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 95.0, 96.0, 95.0, 96.0, 95.0, 97.0, 96.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.5}, {"lowerIsBetter": true, "replicates": [57.0, 56.0, 58.0, 56.0, 56.0, 56.0, 56.0, 56.0, 63.0, 55.0], "unit": "score", "name": "json-parse-financial", "value": 56.9}, {"lowerIsBetter": true, "replicates": [64.0, 65.0, 65.0, 64.0, 64.0, 65.0, 65.0, 65.0, 65.0, 66.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 64.8}, {"lowerIsBetter": true, "replicates": [78.0, 79.0, 79.0, 77.0, 78.0, 78.0, 85.0, 79.0, 78.0, 83.0], "unit": "score", "name": "stanford-crypto-aes", "value": 79.4}, {"lowerIsBetter": true, "replicates": [113.0, 120.0, 112.0, 114.0, 114.0, 123.0, 115.0, 113.0, 114.0, 116.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 115.4}, {"lowerIsBetter": true, "replicates": [140.0, 139.0, 151.0, 151.0, 148.0, 138.0, 144.0, 144.0, 144.0, 147.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 144.6}, {"lowerIsBetter": true, "replicates": [66.0, 70.0, 67.0, 67.0, 69.0, 65.0, 67.0, 64.0, 65.0, 69.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.9}], "name": "kraken", "value": 1507.1000000000001}]} 11:46:33 INFO - Return code: 0 11:46:33 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 11:46:33 INFO - # TBPL SUCCESS # 11:46:33 INFO - Running post-action listener: _resource_record_post_action 11:46:33 INFO - Running post-run listener: _resource_record_post_run 11:46:34 INFO - Total resource usage - Wall time: 1185s; CPU: 13.0%; Read bytes: 4096; Write bytes: 458936320; Read time: 8; Write time: 645144 11:46:34 INFO - install - Wall time: 13s; CPU: 15.0%; Read bytes: 0; Write bytes: 237576192; Read time: 0; Write time: 437808 11:46:34 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 4096; Write bytes: 221360128; Read time: 8; Write time: 207336 11:46:34 INFO - Running post-run listener: _upload_blobber_files 11:46:34 INFO - Blob upload gear active. 11:46:34 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:46:34 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 11:46:34 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', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:46:34 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 Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:46:35 INFO - (blobuploader) - INFO - Open directory for files ... 11:46:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 11:46:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:46:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:46:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 11:46:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:46:36 INFO - (blobuploader) - INFO - Done attempting. 11:46:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 11:46:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:46:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:46:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 11:46:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:46:36 INFO - (blobuploader) - INFO - Done attempting. 11:46:36 INFO - (blobuploader) - INFO - Iteration through files over. 11:46:36 INFO - Return code: 0 11:46:36 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:46:36 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:46:36 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/54643de38a59856e8d85f1d21e9b12ea48b469f1cb43307a38ba1ff6045372924b67a1fd29ba8e87a434dbc1d11664d8bb4bfd6b05ead3f906430e2ea9a629d7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/13bf829b23ee9a2729f513ee2dbf3d3b322a0da543e8ff184230ca19b5fb70255d5872ce8444a920ceba516f6117b43fe6e15ef2cebc58f1530c50cc7e7f9d91"} 11:46:36 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:46:36 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:46:36 INFO - Contents: 11:46:36 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/54643de38a59856e8d85f1d21e9b12ea48b469f1cb43307a38ba1ff6045372924b67a1fd29ba8e87a434dbc1d11664d8bb4bfd6b05ead3f906430e2ea9a629d7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/13bf829b23ee9a2729f513ee2dbf3d3b322a0da543e8ff184230ca19b5fb70255d5872ce8444a920ceba516f6117b43fe6e15ef2cebc58f1530c50cc7e7f9d91"} 11:46:36 INFO - Running post-run listener: copy_logs_to_upload_dir 11:46:36 INFO - Copying logs to upload dir... 11:46:36 INFO - mkdir: /builds/slave/test/build/upload/logs 11:46:37 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1224.445241 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 24 secs) (at 2016-05-17 11:46:37.002718) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-17 11:46:37.005948) ========= 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=8783db0840cc980e80bb0bd400000236-1463509571.83882-1470594797 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/54643de38a59856e8d85f1d21e9b12ea48b469f1cb43307a38ba1ff6045372924b67a1fd29ba8e87a434dbc1d11664d8bb4bfd6b05ead3f906430e2ea9a629d7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/13bf829b23ee9a2729f513ee2dbf3d3b322a0da543e8ff184230ca19b5fb70255d5872ce8444a920ceba516f6117b43fe6e15ef2cebc58f1530c50cc7e7f9d91"} build_url:https://queue.taskcluster.net/v1/task/EWBTWRiQSqaI4to2tTLoHw/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011262 build_url: 'https://queue.taskcluster.net/v1/task/EWBTWRiQSqaI4to2tTLoHw/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/54643de38a59856e8d85f1d21e9b12ea48b469f1cb43307a38ba1ff6045372924b67a1fd29ba8e87a434dbc1d11664d8bb4bfd6b05ead3f906430e2ea9a629d7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/13bf829b23ee9a2729f513ee2dbf3d3b322a0da543e8ff184230ca19b5fb70255d5872ce8444a920ceba516f6117b43fe6e15ef2cebc58f1530c50cc7e7f9d91"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-17 11:46:37.031014) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-17 11:46:37.031337) ========= 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=8783db0840cc980e80bb0bd400000236-1463509571.83882-1470594797 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004564 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-17 11:46:37.114242) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-17 11:46:37.114587) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-17 11:46:37.114876) ========= ========= Total master_lag: 0.17 =========